[vz-users] Fehlersuche-HowTo: 1wirevz und s0vz

Heiko Baumann hbcs at gmx.de
Sun Jun 26 16:36:51 CEST 2016


Hallo Udo, Andras, Martin -

Danke für eure Hinweise, ich komm erst jetzt wieder dazu, mir das 
anzuschauen.

>> hab ich vor ein paar Tagen runterladen, "offiz. Quelle".
> Ok, dann hast du Jessie-Light.

> Jessie nutzt systemd deshalb der Aufruf von vzlogger hiernach:
> http://wiki.volkszaehler.org/software/controller/vzlogger/installation_cpp-version#systemd_start_script 
>
Das dort beschriebene Skript vzlogger.service gabs schon, war alles ok.
>
> In der /boot/config.txt solltest du folgendes am Ende eintragen:
> max_usb_current=1
> gpu_mem=0
> dtparam=i2c_arm=on
> dtparam=spi=off
> enable_uart=1
>
Ok, hab ich.
> 'dtoverlay=w1-gpio,gpiopin=4,pullup=on' solltest du löschen. Du nutzt 
> ja die Erweiterung und nicht den GPIO-Pin4 für 1Wire.
... die Zeile gibts in meiner config.txt gar nicht.
>
> In der /etc/modules sollte folgendes drin stehen:
> i2c-bcm2708
> i2c-dev
> ds2482
> w1-therm
>
Bei mir war noch zusätzlich
snd-bcm2835
aktiviert  (nicht gebrauchter Sound?), hab ich auskommentiert.

> In der /etc/rc.local sollte folgendes stehen:
>
> # Part of DS2482 I2C 1-Wire Master to Volkszaehler 'RaspberryPI deamon'.
>
> echo ds2482 0x18 > /sys/bus/i2c/devices/i2c-1/new_device
>
> # Register I2C RTC bei grosser neuer Erweiterung
> echo ds1307 0x68 > /sys/bus/i2c/devices/i2c-1/new_device
>
Da hab ich inzwischen noch einiges mehr ergänzt. Ich hab an 4 s0 
Eingängen Zähler hängen und nutze mehrere 1wire Eingänge, hoffe die 
Einstellungen unten sind deswegen korrekt:

pi at BauratPi:~ $ cat /etc/rc.local
#!/bin/sh -e
#
# rc.local
#
# This script is executed at the end of each multiuser runlevel.
# Make sure that the script will "exit 0" on success or any other
# value on error.
#
# In order to enable or disable this script just change the execution
# bits.
#
# By default this script does nothing.

# Print the IP address
_IP=$(hostname -I) || true
if [ "$_IP" ]; then
   printf "My IP address is %s\n" "$_IP"
fi

# Part of DS2482 I2C 1-Wire Master to Volkszaehler 'RaspberryPI deamon'.

echo ds2482 0x18 > /sys/bus/i2c/devices/i2c-1/new_device
echo ds2482 0x19 > /sys/bus/i2c/devices/i2c-1/new_device
echo ds2482 0x1a > /sys/bus/i2c/devices/i2c-1/new_device


# Register I2C RTC bei grosser neuer Erweiterung
echo ds1307 0x68 > /sys/bus/i2c/devices/i2c-1/new_device

# GPIOs exportieren und Datenrichtung einstellen, 'Schaltausgang_new'
echo *17* > /sys/class/gpio/export
echo 18 > /sys/class/gpio/export
echo 22 > /sys/class/gpio/export
echo 23 > /sys/class/gpio/export
echo 24 > /sys/class/gpio/export
echo 27 > /sys/class/gpio/export

echo out > /sys/class/gpio/gpio*17*/direction
echo out > /sys/class/gpio/gpio18/direction
echo out > /sys/class/gpio/gpio22/direction
echo out > /sys/class/gpio/gpio23/direction
echo out > /sys/class/gpio/gpio24/direction
echo out > /sys/class/gpio/gpio27/direction

# hwclock -s


exit 0

Dazu noch gleich eine Frage: sind die rot markierten Werte dann auch 
genau die Werte, die in der vzlogger.conf als gpio "kanal" einzutragen 
sind (blau)?

...
      "protocol": "s0",
       "gpio": *17*,
       "resolution": 1000,
       "configureGPIO": true,
       "debounce_delay": 0


Ich hab in meiner "Verzweiflung" inzwischen die Vorlage von hier:
http://wiki.volkszaehler.org/hardware/controllers/raspberry_pi_erweiterung_mit_schaltausgaengen_rev.1#fertiges_image
genommen und auf meine Werte angepasst. Das klappt jetzt zumindest mit 
den 1wire Temperatursensoren, evtl. war es auch der Hinweis von Martin, 
das "interval" auf 10 zu setzen.

Generell: ich glaube, dass das "falsche" Restarten des vzloggers für die 
seltsamen Messergebnisse verantwortlich war.
mit 'sudo service vzlogger restart'  scheint es auf jeden Fall korrekt 
zu funktionieren.

Auf den s0 Kanälen geht noch nicht alles. Es werden wohl laufend 
Ereignisse geholt, aber nur z.T. richtig zugewiesen bzw. ausgewertet.

Erste Frage hab ich oben schon gestellt, bzw. noch etwas verändert:
woher weiß ich, welche GPIO Kanäle ich in der vzlogger.conf zuordnen 
kann? (-> die gleichen, die in rc.local erfasst werden, nehme ich an). 
Dann also die Frage anders: woher weiß ich, welche Kanäle ich in der 
rc.local erfassen muss?

Zweite Frage: wie funktioniert die Aggregation bei diesen 
s0-Stromzählern? Was sind da sinnvolle Einstellungen?
   {
      // Heizungsstrom Waermepumpe GPIO 24
       "enabled": true,
*"allowskip": false,
       "interval": -1,
       "aggtime": -1,
       "aggfixedinterval": false,*
       "channels": [
         {
           "uuid": "9a7ed6c0-f2dc-11e2-b13e-b9abb50897a8",
           "identifier": "Impulse",
           "api": "volkszaehler",
           "middleware": "http://localhost/middleware.php",
*  "aggmode": "none",**
**          "duplicates": 0*
         }
       ],
       "protocol": "s0",
       "gpio": 24,
*  "resolution": 1000,  // ok, hier muss man halt entweder rechnen oder 
spielen, bis es klappt, das krieg ich hin...*
       "configureGPIO": true,
*  "debounce_delay": 0*
     },

Im Anhang mal die komplette conf und das aktuelle Logfile (jetzt aus /tmp).

Zwischenstand also: Land ist in Sicht, aber wie ich auf die GPIO Ports 
komm, ist mir noch unklar. Bedanke mich schon mal für die Hilfe!

LG Heiko

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://demo.volkszaehler.org/pipermail/volkszaehler-users/attachments/20160626/0affb04e/attachment-0001.html>
-------------- next part --------------
{
  "retry": 0,
  "daemon": true,
  "verbosity": 15,
  "log": "/tmp/vzlogger.log",
//  "push": [],
  "local": {
    "enabled": false,
    "port": 8080,
    "index": false,
    "timeout": 0,
    "buffer": 0
  },
  "meters": [
    {
      // PV-Wechselrichter GPIO 18
      "enabled": true,
      "allowskip": false,
      "interval": -1,
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
          "uuid": "7b6afe30-f2dc-11e2-a117-6b7d90ba87df",
          "identifier": "Impulse",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "s0",
      "gpio": 18,
      "resolution": 1000,
      "configureGPIO": true,
      "debounce_delay": 0
    },
    {
      // Betriebsstunden Waermepumpe
      "enabled": true,
      "allowskip": false,
      "interval": -1,
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
          "uuid": "ae9d1b00-f2f5-11e2-8a1f-0dad1c039958",
          "identifier": "Impulse",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "s0",
      "gpio": 22,
      "resolution": 1000,
      "configureGPIO": true,
      "debounce_delay": 0
    },
    {
      // Strom OG GPIO 27
      "enabled": true,
      "allowskip": false,
      "interval": -1,
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
          "uuid": "89277390-f2dc-11e2-94d6-9984a2fec1dc",
          "identifier": "Impulse",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "s0",
      "gpio": 27,
      "resolution": 1000,
      "configureGPIO": true,
      "debounce_delay": 0
    },
    {
      // Strom EG GPIO 23
      "enabled": true,
      "allowskip": false,
      "interval": -1,
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
          "uuid": "90da22c0-f2dc-11e2-a59d-e9b55d71b128",
          "identifier": "Impulse",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "s0",
      "gpio": 23,
      "resolution": 1000,
      "configureGPIO": true,
      "debounce_delay": 0
    },
    {
     // Heizungsstrom Waermepumpe GPIO 24
      "enabled": true,
      "allowskip": false,
      "interval": -1,
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
          "uuid": "9a7ed6c0-f2dc-11e2-b13e-b9abb50897a8",
          "identifier": "Impulse",
          "api": "volkszaehler",
          "middleware": "http://localhost/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "s0",
      "gpio": 24,
      "resolution": 1000,
      "configureGPIO": true,
      "debounce_delay": 0
    },
	
// 1wire Temperatursensoren
    {
      "enabled": true,
      "allowskip": false,
      "interval": 10, 
      "aggtime": -1,
      "aggfixedinterval": false,
      "channels": [
        {
	  // T4 Aussentemperatur channel 10
          "uuid": "53e45780-f2dc-11e2-bb40-e1626f6aa1bd",
          "identifier": "28-0000045c5c7e",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
        {
	  // T2 Sole WP Eintritt channel 7 
          "uuid": "37e34a40-f2dc-11e2-a9f5-617f327e9a54",
          "identifier": "28-0000045d7eb0",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
        {
	  // T2 Sole WP Austritt channel 8  
          "uuid": "3e744e20-f2dc-11e2-ab3d-e5709e8f1bd3",
          "identifier": "28-000004a2845a",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
        {
		  // T3 WW-Puffer channel 9
          "uuid": "46f672b0-f2dc-11e2-8c00-43a2ff77fb28",
          "identifier": "28-0000045d2497",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
        {
          // T5 FBH Vorlauf channel 11
	  "uuid": "614b6c60-f2dc-11e2-8b34-43269275292a",
          "identifier": "28-000004f1c7c6",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
        {
	  // T5 FBH Ruecklauf channel 28
          "uuid": "e5cd78a0-33fc-11e3-92ab-25b39d4959eb",
          "identifier": "28-000004f2467e",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
		{
	  // T1 Soleverteiler 1 Austritt channel 1
          "uuid": "c80251e0-f2db-11e2-8178-ef2453dba49c",
          "identifier": "28-000004c969de",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
		{
	  // T1 Soleverteiler 1 Eintritt channel 2
          "uuid": "06e27ce0-f2dc-11e2-9196-1793d6d6626c",
          "identifier": "28-000004c96a87",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
         {
	  // T1 Soleverteiler 2 Austritt channel 4 
	  "uuid": "1843ebf0-f2dc-11e2-b68a-0d188c147a46",
          "identifier": "28-000004c9583f",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
		 {
	  //  T1 Soleverteiler 2 Eintritt ch 3 
          "uuid": "112ddc60-f2dc-11e2-9294-971d5a648238",
          "identifier": "28-000004c963b9",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
		{
	  //  T1 Soleverteiler 3 Austritt channel 5
          "uuid": "1fb4b660-f2dc-11e2-9685-936d7367e7ac",
          "identifier": "28-000004c913d5",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        },
		{
	  // T1 Soleverteiler 3 Eintritt - channel 6
          "uuid": "267f2810-f2dc-11e2-8d7c-cb14f79472e0",
          "identifier": "28-0000045c6924",
          "api": "volkszaehler",
          "middleware": "http://127.0.0.1/middleware.php",
          "aggmode": "none",
          "duplicates": 0
        }
      ],
      "protocol": "w1therm"
    }
  ]
}
-------------- next part --------------
[Jun 26 16:29:33]       Opened logfile /tmp/vzlogger.log
[Jun 26 16:29:33][push] No pushDataServer defined.
[Jun 26 16:29:33][]     ===> Start meters
[Jun 26 16:29:33][s0]   counter_thread created
[Jun 26 16:29:33][mtr0] Meter connection established
[Jun 26 16:29:33][mtr0] Meter thread started
[Jun 26 16:29:33][mtr0] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn0] Logging thread started
[Jun 26 16:29:33][s0]   counter_thread created
[Jun 26 16:29:33][mtr1] Meter connection established
[Jun 26 16:29:33][mtr1] Meter thread started
[Jun 26 16:29:33][mtr1] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn1] Logging thread started
[Jun 26 16:29:33][s0]   counter_thread created
[Jun 26 16:29:33][mtr2] Meter connection established
[Jun 26 16:29:33][mtr2] Meter thread started
[Jun 26 16:29:33][mtr2] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn2] Logging thread started
[Jun 26 16:29:33][s0]   counter_thread created
[Jun 26 16:29:33][mtr3] Meter connection established
[Jun 26 16:29:33][mtr3] Meter thread started
[Jun 26 16:29:33][mtr3] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn3] Logging thread started
[Jun 26 16:29:33][s0]   counter_thread created
[Jun 26 16:29:33][mtr4] Meter connection established
[Jun 26 16:29:33][mtr4] Meter thread started
[Jun 26 16:29:33][mtr4] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn4] Logging thread started
[Jun 26 16:29:33][w1t]  open found 12 w1 devices
[Jun 26 16:29:33][mtr5] Meter connection established
[Jun 26 16:29:33][mtr5] Meter thread started
[Jun 26 16:29:33][mtr5] Meter is opened. Starting channels.
[Jun 26 16:29:33][chn0] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn0] Using default volkszaehler api.
[Jun 26 16:29:33][mtr0] Number of readers: 4
[Jun 26 16:29:33][mtr0] Config.daemon: 1
[Jun 26 16:29:33][mtr0] Config.local: 0
[Jun 26 16:29:33][s0]   Counter thread started with blocking hwif
[Jun 26 16:29:33][s0]   Counter thread started with blocking hwif
[Jun 26 16:29:33][mtr1] Number of readers: 4
[Jun 26 16:29:33][mtr1] Config.daemon: 1
[Jun 26 16:29:33][mtr1] Config.local: 0
[Jun 26 16:29:33][chn1] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn1] Using default volkszaehler api.
[Jun 26 16:29:33][s0]   Counter thread started with blocking hwif
[Jun 26 16:29:33][mtr2] Number of readers: 4
[Jun 26 16:29:33][mtr2] Config.daemon: 1
[Jun 26 16:29:33][mtr2] Config.local: 0
[Jun 26 16:29:33][chn2] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn2] Using default volkszaehler api.
[Jun 26 16:29:33][s0]   Counter thread started with blocking hwif
[Jun 26 16:29:33][mtr3] Number of readers: 4
[Jun 26 16:29:33][mtr3] Config.daemon: 1
[Jun 26 16:29:33][mtr3] Config.local: 0
[Jun 26 16:29:33][chn3] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn3] Using default volkszaehler api.
[Jun 26 16:29:33][s0]   Counter thread started with blocking hwif
[Jun 26 16:29:33][mtr4] Number of readers: 4
[Jun 26 16:29:33][mtr4] Config.daemon: 1
[Jun 26 16:29:33][mtr4] Config.local: 0
[Jun 26 16:29:33][chn4] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn4] Using default volkszaehler api.
[Jun 26 16:29:33][mtr5] Number of readers: 400
[Jun 26 16:29:33][mtr5] Config.daemon: 1
[Jun 26 16:29:33][mtr5] Config.local: 0
[Jun 26 16:29:33][chn5] Logging thread started
[Jun 26 16:29:33][chn6] Logging thread started
[Jun 26 16:29:33][chn7] Logging thread started
[Jun 26 16:29:33][chn8] Logging thread started
[Jun 26 16:29:33][chn9] Logging thread started
[Jun 26 16:29:33][chn10]Logging thread started
[Jun 26 16:29:33][chn11]Logging thread started
[Jun 26 16:29:33][chn12]Logging thread started
[Jun 26 16:29:33][chn13]Logging thread started
[Jun 26 16:29:33][chn14]Logging thread started
[Jun 26 16:29:33][chn15]Logging thread started
[Jun 26 16:29:33][chn16]Logging thread started
[Jun 26 16:29:33][]     Startup done.
[Jun 26 16:29:33][chn6] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn6] Using default volkszaehler api.
[Jun 26 16:29:33][chn7] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn7] Using default volkszaehler api.
[Jun 26 16:29:33][chn8] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn8] Using default volkszaehler api.
[Jun 26 16:29:33][chn9] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn9] Using default volkszaehler api.
[Jun 26 16:29:33][chn10]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn10]Using default volkszaehler api.
[Jun 26 16:29:33][chn11]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn11]Using default volkszaehler api.
[Jun 26 16:29:33][chn12]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn12]Using default volkszaehler api.
[Jun 26 16:29:33][chn13]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn13]Using default volkszaehler api.
[Jun 26 16:29:33][chn5] Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn5] Using default volkszaehler api.
[Jun 26 16:29:33][chn14]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn14]Using default volkszaehler api.
[Jun 26 16:29:33][chn15]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn16]Start logging thread for volkszaehler-api. Running as daemon: yes
[Jun 26 16:29:33][chn15]Using default volkszaehler api.
[Jun 26 16:29:33][chn16]Using default volkszaehler api.
[Jun 26 16:29:34][w1t]  read 11.750000 from /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=11750
)
[Jun 26 16:29:34][w1t]  reading w1 device 28-0000045c6924 returned 11.750000
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:34][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:35][w1t]  read 13.437000 from /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=13437
)
[Jun 26 16:29:35][w1t]  reading w1 device 28-0000045c5c7e returned 13.437000
[Jun 26 16:29:35][s0]   Reading S0 - returning 1 readings (n=1 n_neg = 0)
[Jun 26 16:29:35][mtr3] Got 1 new readings from meter:
[Jun 26 16:29:35][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951374823
[Jun 26 16:29:35][chn3] Adding reading to queue (value=1.00 ts=1466951374823)
[Jun 26 16:29:35][chn3] ==> number of tuples: 1
[Jun 26 16:29:35][chn3] compare: 0 1466951374823
[Jun 26 16:29:35][chn3] JSON request body: [ [ 1466951374823, 1 ] ]
[Jun 26 16:29:35][chn3] CURL: Hostname was NOT found in DNS cache
[Jun 26 16:29:35][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:35][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#0)
[Jun 26 16:29:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:35][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:35][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:35][chn3] CURL: Sent '[ [ 1466951374823, 1 ] ]' bytes
[Jun 26 16:29:35][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:35][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:35][chn3] CURL: Received 26 bytes
[Jun 26 16:29:35][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:35][chn3] CURL: Closing connection 0
[Jun 26 16:29:35][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:36][w1t]  read 42.937000 from /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=42937
)
[Jun 26 16:29:36][w1t]  reading w1 device 28-0000045d2497 returned 42.937000
[Jun 26 16:29:36][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:36][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:36][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:36][mtr3] Reading: id=Power/StringItentifier: value=1968.29 ts=1466951376652
[Jun 26 16:29:36][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951376652
[Jun 26 16:29:36][chn3] Adding reading to queue (value=1.00 ts=1466951376652)
[Jun 26 16:29:36][chn3] ==> number of tuples: 1
[Jun 26 16:29:36][chn3] compare: 1466951374823 1466951376652
[Jun 26 16:29:36][chn3] JSON request body: [ [ 1466951376652, 1 ] ]
[Jun 26 16:29:36][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:36][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:36][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#1)
[Jun 26 16:29:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:36][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:36][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:36][chn3] CURL: Sent '[ [ 1466951376652, 1 ] ]' bytes
[Jun 26 16:29:36][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:36][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:36][chn3] CURL: Received 26 bytes
[Jun 26 16:29:36][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:36][chn3] CURL: Closing connection 1
[Jun 26 16:29:36][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:36][w1t]  read 21.875000 from /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=21875
)
[Jun 26 16:29:36][w1t]  reading w1 device 28-0000045d7eb0 returned 21.875000
[Jun 26 16:29:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:37][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:37][s0]   Reading S0 - returning 1 readings (n=1 n_neg = 0)
[Jun 26 16:29:37][mtr2] Got 1 new readings from meter:
[Jun 26 16:29:37][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951377690
[Jun 26 16:29:37][chn2] Adding reading to queue (value=1.00 ts=1466951377690)
[Jun 26 16:29:37][chn2] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:37][chn2] ==> number of tuples: 1
[Jun 26 16:29:37][chn2] compare: 0 1466951377690
[Jun 26 16:29:37][chn2] JSON request body: [ [ 1466951377690, 1 ] ]
[Jun 26 16:29:37][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:29:37][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:37][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#2)
[Jun 26 16:29:37][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:29:37][chn2] CURL: Sent '[ [ 1466951377690, 1 ] ]' bytes
[Jun 26 16:29:37][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:37][w1t]  read 22.062000 from /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=22062
)
[Jun 26 16:29:37][w1t]  reading w1 device 28-000004a2845a returned 22.062000
[Jun 26 16:29:37][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:37][chn2] CURL: Received 26 bytes
[Jun 26 16:29:37][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:37][chn2] CURL: Closing connection 2
[Jun 26 16:29:37][chn2] CURL Request succeeded with code: 200
[Jun 26 16:29:38][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:38][w1t]  read 12.000000 from /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=12000
)
[Jun 26 16:29:38][w1t]  reading w1 device 28-000004c913d5 returned 12.000000
[Jun 26 16:29:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:38][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:38][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:38][mtr3] Reading: id=Power/StringItentifier: value=1971.52 ts=1466951378478
[Jun 26 16:29:38][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951378478
[Jun 26 16:29:38][chn3] Adding reading to queue (value=1.00 ts=1466951378478)
[Jun 26 16:29:38][chn3] ==> number of tuples: 1
[Jun 26 16:29:38][chn3] compare: 1466951376652 1466951378478
[Jun 26 16:29:38][chn3] JSON request body: [ [ 1466951378478, 1 ] ]
[Jun 26 16:29:38][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:38][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:38][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#3)
[Jun 26 16:29:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:38][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:38][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:38][chn3] CURL: Sent '[ [ 1466951378478, 1 ] ]' bytes
[Jun 26 16:29:38][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:38][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:38][chn3] CURL: Received 26 bytes
[Jun 26 16:29:38][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:38][chn3] CURL: Closing connection 3
[Jun 26 16:29:38][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:39][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=12125
)
[Jun 26 16:29:39][w1t]  reading w1 device 28-000004c9583f returned 12.125000
[Jun 26 16:29:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:40][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c963b9/w1_slave (t=11750
)
[Jun 26 16:29:40][w1t]  reading w1 device 28-000004c963b9 returned 11.750000
[Jun 26 16:29:40][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:40][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:40][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:40][mtr3] Reading: id=Power/StringItentifier: value=1972.60 ts=1466951380303
[Jun 26 16:29:40][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951380303
[Jun 26 16:29:40][chn3] Adding reading to queue (value=1.00 ts=1466951380303)
[Jun 26 16:29:40][chn3] ==> number of tuples: 1
[Jun 26 16:29:40][chn3] compare: 1466951378478 1466951380303
[Jun 26 16:29:40][chn3] JSON request body: [ [ 1466951380303, 1 ] ]
[Jun 26 16:29:40][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:40][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:40][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:40][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#4)
[Jun 26 16:29:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:40][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:40][chn3] CURL: Sent '[ [ 1466951380303, 1 ] ]' bytes
[Jun 26 16:29:40][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:40][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:40][chn3] CURL: Received 26 bytes
[Jun 26 16:29:40][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:40][chn3] CURL: Closing connection 4
[Jun 26 16:29:40][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:41][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c969de/w1_slave (t=12125
)
[Jun 26 16:29:41][w1t]  reading w1 device 28-000004c969de returned 12.125000
[Jun 26 16:29:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:41][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c96a87/w1_slave (t=11750
)
[Jun 26 16:29:41][w1t]  reading w1 device 28-000004c96a87 returned 11.750000
[Jun 26 16:29:42][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:42][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:42][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:42][mtr3] Reading: id=Power/StringItentifier: value=1968.29 ts=1466951382132
[Jun 26 16:29:42][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951382132
[Jun 26 16:29:42][chn3] Adding reading to queue (value=1.00 ts=1466951382132)
[Jun 26 16:29:42][chn3] ==> number of tuples: 1
[Jun 26 16:29:42][chn3] compare: 1466951380303 1466951382132
[Jun 26 16:29:42][chn3] JSON request body: [ [ 1466951382132, 1 ] ]
[Jun 26 16:29:42][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:42][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:42][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:42][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#5)
[Jun 26 16:29:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:42][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:42][chn3] CURL: Sent '[ [ 1466951382132, 1 ] ]' bytes
[Jun 26 16:29:42][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:42][w1t]  read 24.000000 from /sys/bus/w1/devices/28-000004f2467e/w1_slave (t=24000
)
[Jun 26 16:29:42][w1t]  reading w1 device 28-000004f2467e returned 24.000000
[Jun 26 16:29:42][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:42][chn3] CURL: Received 26 bytes
[Jun 26 16:29:42][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:42][chn3] CURL: Closing connection 5
[Jun 26 16:29:42][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:43][w1t]  read 23.875000 from /sys/bus/w1/devices/28-000004f1c7c6/w1_slave (t=23875
)
[Jun 26 16:29:43][w1t]  reading w1 device 28-000004f1c7c6 returned 23.875000
[Jun 26 16:29:43][mtr5] Got 12 new readings from meter:
[Jun 26 16:29:43][mtr5] Reading: id=28-0000045c6924/StringItentifier: value=11.75 ts=1466951374548
[Jun 26 16:29:43][mtr5] Reading: id=28-0000045c5c7e/StringItentifier: value=13.44 ts=1466951375358
[Jun 26 16:29:43][mtr5] Reading: id=28-0000045d2497/StringItentifier: value=42.94 ts=1466951376168
[Jun 26 16:29:43][mtr5] Reading: id=28-0000045d7eb0/StringItentifier: value=21.88 ts=1466951376978
[Jun 26 16:29:43][mtr5] Reading: id=28-000004a2845a/StringItentifier: value=22.06 ts=1466951377791
[Jun 26 16:29:43][mtr5] Reading: id=28-000004c913d5/StringItentifier: value=12.00 ts=1466951378608
[Jun 26 16:29:43][mtr5] Reading: id=28-000004c9583f/StringItentifier: value=12.12 ts=1466951379428
[Jun 26 16:29:43][mtr5] Reading: id=28-000004c963b9/StringItentifier: value=11.75 ts=1466951380241
[Jun 26 16:29:43][mtr5] Reading: id=28-000004c969de/StringItentifier: value=12.12 ts=1466951381060
[Jun 26 16:29:43][mtr5] Reading: id=28-000004c96a87/StringItentifier: value=11.75 ts=1466951381880
[Jun 26 16:29:43][mtr5] Reading: id=28-000004f2467e/StringItentifier: value=24.00 ts=1466951382755
[Jun 26 16:29:43][mtr5] Reading: id=28-000004f1c7c6/StringItentifier: value=23.88 ts=1466951383647
[Jun 26 16:29:43][chn5] Adding reading to queue (value=13.44 ts=1466951375358)
[Jun 26 16:29:43][chn6] Adding reading to queue (value=21.88 ts=1466951376978)
[Jun 26 16:29:43][chn7] Adding reading to queue (value=22.06 ts=1466951377791)
[Jun 26 16:29:43][chn8] Adding reading to queue (value=42.94 ts=1466951376168)
[Jun 26 16:29:43][chn9] Adding reading to queue (value=23.88 ts=1466951383647)
[Jun 26 16:29:43][chn10]Adding reading to queue (value=24.00 ts=1466951382755)
[Jun 26 16:29:43][chn11]Adding reading to queue (value=12.12 ts=1466951381060)
[Jun 26 16:29:43][chn12]Adding reading to queue (value=11.75 ts=1466951381880)
[Jun 26 16:29:43][chn13]Adding reading to queue (value=12.12 ts=1466951379428)
[Jun 26 16:29:43][chn14]Adding reading to queue (value=11.75 ts=1466951380241)
[Jun 26 16:29:43][chn15]Adding reading to queue (value=12.00 ts=1466951378608)
[Jun 26 16:29:43][chn16]Adding reading to queue (value=11.75 ts=1466951374548)
[Jun 26 16:29:43][chn5] ==> number of tuples: 1
[Jun 26 16:29:43][chn5] compare: 0 1466951375358
[Jun 26 16:29:43][chn5] JSON request body: [ [ 1466951375358, 13.436999999999999 ] ]
[Jun 26 16:29:43][chn5] CURL: Hostname was found in DNS cache
[Jun 26 16:29:43][chn5] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:43][chn5] Buffer dump (size=0): {}
[Jun 26 16:29:43][chn5] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#6)
[Jun 26 16:29:43][chn6] ==> number of tuples: 1
[Jun 26 16:29:43][chn6] compare: 0 1466951376978
[Jun 26 16:29:43][chn6] Buffer dump (size=0): {}
[Jun 26 16:29:43][chn7] ==> number of tuples: 1
[Jun 26 16:29:43][chn7] compare: 0 1466951377791
[Jun 26 16:29:43][chn7] Buffer dump (size=0): {}
[Jun 26 16:29:43][chn8] ==> number of tuples: 1
[Jun 26 16:29:43][chn8] compare: 0 1466951376168
[Jun 26 16:29:43][chn8] Buffer dump (size=0): {}
[Jun 26 16:29:43][chn5] CURL: Sent 41 bytes.. 
[Jun 26 16:29:43][chn5] CURL: Sent '[ [ 1466951375358, 13.436999999999999 ] ]' bytes
[Jun 26 16:29:43][chn9] ==> number of tuples: 1
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:43][chn9] compare: 0 1466951383647
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:43][chn9] Buffer dump (size=1): {23.8750,}
[Jun 26 16:29:43][chn10]==> number of tuples: 1
[Jun 26 16:29:43][chn10]compare: 0 1466951382755
[Jun 26 16:29:43][chn5] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:29:43][chn10]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn11]==> number of tuples: 1
[Jun 26 16:29:43][chn11]compare: 0 1466951381060
[Jun 26 16:29:43][chn11]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn12]==> number of tuples: 1
[Jun 26 16:29:43][chn12]compare: 0 1466951381880
[Jun 26 16:29:43][chn12]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn13]==> number of tuples: 1
[Jun 26 16:29:43][chn13]compare: 0 1466951379428
[Jun 26 16:29:43][chn13]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn14]==> number of tuples: 1
[Jun 26 16:29:43][chn14]compare: 0 1466951380241
[Jun 26 16:29:43][chn14]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn15]==> number of tuples: 1
[Jun 26 16:29:43][chn15]compare: 0 1466951378608
[Jun 26 16:29:43][chn15]Buffer dump (size=0): {}
[Jun 26 16:29:43][chn16]==> number of tuples: 1
[Jun 26 16:29:43][chn16]compare: 0 1466951374548
[Jun 26 16:29:43][chn16]Buffer dump (size=0): {}
[Jun 26 16:29:43][mtr5] Next reading in 10 seconds
[Jun 26 16:29:43][chn5] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:43][chn5] CURL: Received 26 bytes
[Jun 26 16:29:43][chn5] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:43][chn5] CURL: Closing connection 6
[Jun 26 16:29:43][chn6] JSON request body: [ [ 1466951376978, 21.875 ] ]
[Jun 26 16:29:43][chn6] CURL: Hostname was found in DNS cache
[Jun 26 16:29:43][chn6] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:43][chn6] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#7)
[Jun 26 16:29:43][chn6] CURL: Sent 29 bytes.. 
[Jun 26 16:29:43][chn6] CURL: Sent '[ [ 1466951376978, 21.875 ] ]' bytes
[Jun 26 16:29:43][chn6] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:29:43][chn5] CURL Request succeeded with code: 200
[Jun 26 16:29:43][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:44][chn6] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn6] CURL: Received 26 bytes
[Jun 26 16:29:44][chn6] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn6] CURL: Closing connection 7
[Jun 26 16:29:44][chn7] JSON request body: [ [ 1466951377791, 22.062000000000001 ] ]
[Jun 26 16:29:44][chn7] CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn7] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn7] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#8)
[Jun 26 16:29:44][chn7] CURL: Sent 41 bytes.. 
[Jun 26 16:29:44][chn7] CURL: Sent '[ [ 1466951377791, 22.062000000000001 ] ]' bytes
[Jun 26 16:29:44][chn7] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:29:44][chn6] CURL Request succeeded with code: 200
[Jun 26 16:29:44][chn7] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn7] CURL: Received 26 bytes
[Jun 26 16:29:44][chn7] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn7] CURL: Closing connection 8
[Jun 26 16:29:44][chn8] JSON request body: [ [ 1466951376168, 42.936999999999998 ] ]
[Jun 26 16:29:44][chn8] CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn8] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn8] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#9)
[Jun 26 16:29:44][chn8] CURL: Sent 41 bytes.. 
[Jun 26 16:29:44][chn8] CURL: Sent '[ [ 1466951376168, 42.936999999999998 ] ]' bytes
[Jun 26 16:29:44][chn8] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:29:44][chn7] CURL Request succeeded with code: 200
[Jun 26 16:29:44][chn8] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn8] CURL: Received 26 bytes
[Jun 26 16:29:44][chn8] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn8] CURL: Closing connection 9
[Jun 26 16:29:44][chn9] JSON request body: [ [ 1466951383647, 23.875 ] ]
[Jun 26 16:29:44][chn9] CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn9] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn9] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#10)
[Jun 26 16:29:44][chn9] CURL: Sent 29 bytes.. 
[Jun 26 16:29:44][chn9] CURL: Sent '[ [ 1466951383647, 23.875 ] ]' bytes
[Jun 26 16:29:44][chn9] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:29:44][chn8] CURL Request succeeded with code: 200
[Jun 26 16:29:44][chn9] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn9] CURL: Received 26 bytes
[Jun 26 16:29:44][chn9] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn9] CURL: Closing connection 10
[Jun 26 16:29:44][chn10]JSON request body: [ [ 1466951382755, 24 ] ]
[Jun 26 16:29:44][chn10]CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn10]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn10]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#11)
[Jun 26 16:29:44][chn10]CURL: Sent 25 bytes.. 
[Jun 26 16:29:44][chn10]CURL: Sent '[ [ 1466951382755, 24 ] ]' bytes
[Jun 26 16:29:44][chn10]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:29:44][chn9] CURL Request succeeded with code: 200
[Jun 26 16:29:44][chn10]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn10]CURL: Received 26 bytes
[Jun 26 16:29:44][chn10]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn10]CURL: Closing connection 11
[Jun 26 16:29:44][chn11]JSON request body: [ [ 1466951381060, 12.125 ] ]
[Jun 26 16:29:44][chn11]CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn11]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn11]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#12)
[Jun 26 16:29:44][chn11]CURL: Sent 29 bytes.. 
[Jun 26 16:29:44][chn11]CURL: Sent '[ [ 1466951381060, 12.125 ] ]' bytes
[Jun 26 16:29:44][chn11]CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:29:44][chn10]CURL Request succeeded with code: 200
[Jun 26 16:29:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:44][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:44][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:44][mtr3] Reading: id=Power/StringItentifier: value=1971.52 ts=1466951383958
[Jun 26 16:29:44][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951383958
[Jun 26 16:29:44][chn3] Adding reading to queue (value=1.00 ts=1466951383958)
[Jun 26 16:29:44][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:44][chn3] ==> number of tuples: 1
[Jun 26 16:29:44][chn3] compare: 1466951382132 1466951383958
[Jun 26 16:29:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:44][chn11]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:44][chn11]CURL: Received 26 bytes
[Jun 26 16:29:44][chn11]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:44][chn11]CURL: Closing connection 12
[Jun 26 16:29:44][chn3] JSON request body: [ [ 1466951383958, 1 ] ]
[Jun 26 16:29:44][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:44][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:44][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#13)
[Jun 26 16:29:44][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:44][chn3] CURL: Sent '[ [ 1466951383958, 1 ] ]' bytes
[Jun 26 16:29:44][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:44][chn11]CURL Request succeeded with code: 200
[Jun 26 16:29:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:45][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn3] CURL: Received 26 bytes
[Jun 26 16:29:45][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn3] CURL: Closing connection 13
[Jun 26 16:29:45][chn12]JSON request body: [ [ 1466951381880, 11.75 ] ]
[Jun 26 16:29:45][chn12]CURL: Hostname was found in DNS cache
[Jun 26 16:29:45][chn12]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:45][chn12]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#14)
[Jun 26 16:29:45][chn12]CURL: Sent 28 bytes.. 
[Jun 26 16:29:45][chn12]CURL: Sent '[ [ 1466951381880, 11.75 ] ]' bytes
[Jun 26 16:29:45][chn12]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:29:45][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:45][chn12]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn12]CURL: Received 26 bytes
[Jun 26 16:29:45][chn12]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn12]CURL: Closing connection 14
[Jun 26 16:29:45][chn13]JSON request body: [ [ 1466951379428, 12.125 ] ]
[Jun 26 16:29:45][chn13]CURL: Hostname was found in DNS cache
[Jun 26 16:29:45][chn13]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:45][chn13]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#15)
[Jun 26 16:29:45][chn13]CURL: Sent 29 bytes.. 
[Jun 26 16:29:45][chn13]CURL: Sent '[ [ 1466951379428, 12.125 ] ]' bytes
[Jun 26 16:29:45][chn13]CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:29:45][chn12]CURL Request succeeded with code: 200
[Jun 26 16:29:45][chn13]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn13]CURL: Received 26 bytes
[Jun 26 16:29:45][chn13]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn13]CURL: Closing connection 15
[Jun 26 16:29:45][chn14]JSON request body: [ [ 1466951380241, 11.75 ] ]
[Jun 26 16:29:45][chn14]CURL: Hostname was found in DNS cache
[Jun 26 16:29:45][chn14]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:45][chn14]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#16)
[Jun 26 16:29:45][chn14]CURL: Sent 28 bytes.. 
[Jun 26 16:29:45][chn14]CURL: Sent '[ [ 1466951380241, 11.75 ] ]' bytes
[Jun 26 16:29:45][chn14]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:29:45][chn13]CURL Request succeeded with code: 200
[Jun 26 16:29:45][chn14]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn14]CURL: Received 26 bytes
[Jun 26 16:29:45][chn14]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn14]CURL: Closing connection 16
[Jun 26 16:29:45][chn15]JSON request body: [ [ 1466951378608, 12 ] ]
[Jun 26 16:29:45][chn15]CURL: Hostname was found in DNS cache
[Jun 26 16:29:45][chn15]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:45][chn15]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#17)
[Jun 26 16:29:45][chn15]CURL: Sent 25 bytes.. 
[Jun 26 16:29:45][chn15]CURL: Sent '[ [ 1466951378608, 12 ] ]' bytes
[Jun 26 16:29:45][chn15]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:29:45][chn14]CURL Request succeeded with code: 200
[Jun 26 16:29:45][chn15]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn15]CURL: Received 26 bytes
[Jun 26 16:29:45][chn15]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn15]CURL: Closing connection 17
[Jun 26 16:29:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:45][chn16]JSON request body: [ [ 1466951374548, 11.75 ] ]
[Jun 26 16:29:45][chn16]CURL: Hostname was found in DNS cache
[Jun 26 16:29:45][chn16]CURL:   Trying 127.0.0.1...
[Jun 26 16:29:45][chn16]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#18)
[Jun 26 16:29:45][chn16]CURL: Sent 28 bytes.. 
[Jun 26 16:29:45][chn16]CURL: Sent '[ [ 1466951374548, 11.75 ] ]' bytes
[Jun 26 16:29:45][chn16]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:29:45][chn15]CURL Request succeeded with code: 200
[Jun 26 16:29:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:45][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:45][chn16]CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:45][chn16]CURL: Received 26 bytes
[Jun 26 16:29:45][chn16]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:45][chn16]CURL: Closing connection 18
[Jun 26 16:29:45][chn16]CURL Request succeeded with code: 200
[Jun 26 16:29:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:46][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:46][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:46][mtr3] Reading: id=Power/StringItentifier: value=1976.94 ts=1466951385779
[Jun 26 16:29:46][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951385779
[Jun 26 16:29:46][chn3] Adding reading to queue (value=1.00 ts=1466951385779)
[Jun 26 16:29:46][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:46][chn3] ==> number of tuples: 1
[Jun 26 16:29:46][chn3] compare: 1466951383958 1466951385779
[Jun 26 16:29:46][chn3] JSON request body: [ [ 1466951385779, 1 ] ]
[Jun 26 16:29:46][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:46][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:46][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#19)
[Jun 26 16:29:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:46][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:46][chn3] CURL: Sent '[ [ 1466951385779, 1 ] ]' bytes
[Jun 26 16:29:46][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:46][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:46][chn3] CURL: Received 26 bytes
[Jun 26 16:29:46][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:46][chn3] CURL: Closing connection 19
[Jun 26 16:29:46][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:47][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:47][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:47][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:47][mtr3] Reading: id=Power/StringItentifier: value=1971.52 ts=1466951387605
[Jun 26 16:29:47][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951387605
[Jun 26 16:29:47][chn3] Adding reading to queue (value=1.00 ts=1466951387605)
[Jun 26 16:29:47][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:47][chn3] ==> number of tuples: 1
[Jun 26 16:29:47][chn3] compare: 1466951385779 1466951387605
[Jun 26 16:29:47][chn3] JSON request body: [ [ 1466951387605, 1 ] ]
[Jun 26 16:29:47][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:47][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:47][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#20)
[Jun 26 16:29:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:47][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:47][chn3] CURL: Sent '[ [ 1466951387605, 1 ] ]' bytes
[Jun 26 16:29:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:47][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:47][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:47][chn3] CURL: Received 26 bytes
[Jun 26 16:29:47][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:47][chn3] CURL: Closing connection 20
[Jun 26 16:29:47][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:49][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:49][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:49][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:49][mtr2] Got 2 new readings from meter:
[Jun 26 16:29:49][mtr2] Reading: id=Power/StringItentifier: value=302.95 ts=1466951389573
[Jun 26 16:29:49][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951389573
[Jun 26 16:29:49][chn2] Adding reading to queue (value=1.00 ts=1466951389573)
[Jun 26 16:29:49][chn2] ==> number of tuples: 1
[Jun 26 16:29:49][chn2] compare: 1466951377690 1466951389573
[Jun 26 16:29:49][chn2] JSON request body: [ [ 1466951389573, 1 ] ]
[Jun 26 16:29:49][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:29:49][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:49][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:49][mtr3] Reading: id=Power/StringItentifier: value=1967.21 ts=1466951389435
[Jun 26 16:29:49][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951389435
[Jun 26 16:29:49][chn3] Adding reading to queue (value=1.00 ts=1466951389435)
[Jun 26 16:29:49][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:49][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:49][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#21)
[Jun 26 16:29:49][chn2] Buffer dump (size=0): {}
[Jun 26 16:29:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:49][chn3] ==> number of tuples: 1
[Jun 26 16:29:49][chn3] compare: 1466951387605 1466951389435
[Jun 26 16:29:49][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:29:49][chn2] CURL: Sent '[ [ 1466951389573, 1 ] ]' bytes
[Jun 26 16:29:49][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:50][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:50][chn2] CURL: Received 26 bytes
[Jun 26 16:29:50][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:50][chn2] CURL: Closing connection 21
[Jun 26 16:29:50][chn3] JSON request body: [ [ 1466951389435, 1 ] ]
[Jun 26 16:29:50][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:50][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:50][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#22)
[Jun 26 16:29:50][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:50][chn3] CURL: Sent '[ [ 1466951389435, 1 ] ]' bytes
[Jun 26 16:29:50][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:50][chn2] CURL Request succeeded with code: 200
[Jun 26 16:29:50][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:50][chn3] CURL: Received 26 bytes
[Jun 26 16:29:50][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:50][chn3] CURL: Closing connection 22
[Jun 26 16:29:50][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:51][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:51][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:51][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:51][mtr3] Reading: id=Power/StringItentifier: value=1966.14 ts=1466951391266
[Jun 26 16:29:51][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951391266
[Jun 26 16:29:51][chn3] Adding reading to queue (value=1.00 ts=1466951391266)
[Jun 26 16:29:51][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:51][chn3] ==> number of tuples: 1
[Jun 26 16:29:51][chn3] compare: 1466951389435 1466951391266
[Jun 26 16:29:51][chn3] JSON request body: [ [ 1466951391266, 1 ] ]
[Jun 26 16:29:51][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:51][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:51][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#23)
[Jun 26 16:29:51][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:51][chn3] CURL: Sent '[ [ 1466951391266, 1 ] ]' bytes
[Jun 26 16:29:51][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:51][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:51][chn3] CURL: Received 26 bytes
[Jun 26 16:29:51][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:51][chn3] CURL: Closing connection 23
[Jun 26 16:29:51][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:53][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:53][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:53][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:53][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951393103
[Jun 26 16:29:53][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951393103
[Jun 26 16:29:53][chn3] Adding reading to queue (value=1.00 ts=1466951393103)
[Jun 26 16:29:53][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:53][chn3] ==> number of tuples: 1
[Jun 26 16:29:53][chn3] compare: 1466951391266 1466951393103
[Jun 26 16:29:53][chn3] JSON request body: [ [ 1466951393103, 1 ] ]
[Jun 26 16:29:53][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:53][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:53][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#24)
[Jun 26 16:29:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:53][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:53][chn3] CURL: Sent '[ [ 1466951393103, 1 ] ]' bytes
[Jun 26 16:29:53][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:54][w1t]  read 11.750000 from /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=11750
)
[Jun 26 16:29:54][w1t]  reading w1 device 28-0000045c6924 returned 11.750000
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:54][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:55][w1t]  read 13.437000 from /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=13437
)
[Jun 26 16:29:55][w1t]  reading w1 device 28-0000045c5c7e returned 13.437000
[Jun 26 16:29:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:55][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:55][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:55][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951394940
[Jun 26 16:29:55][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951394940
[Jun 26 16:29:55][chn3] Adding reading to queue (value=1.00 ts=1466951394940)
[Jun 26 16:29:55][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:29:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:55][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:55][chn3] CURL: Received 26 bytes
[Jun 26 16:29:55][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:55][chn3] CURL: Closing connection 24
[Jun 26 16:29:55][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:55][chn3] ==> number of tuples: 1
[Jun 26 16:29:55][chn3] compare: 1466951393103 1466951394940
[Jun 26 16:29:55][chn3] JSON request body: [ [ 1466951394940, 1 ] ]
[Jun 26 16:29:55][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:55][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:55][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#25)
[Jun 26 16:29:55][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:55][chn3] CURL: Sent '[ [ 1466951394940, 1 ] ]' bytes
[Jun 26 16:29:55][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:56][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:56][chn3] CURL: Received 26 bytes
[Jun 26 16:29:56][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:56][chn3] CURL: Closing connection 25
[Jun 26 16:29:56][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:56][w1t]  read 42.937000 from /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=42937
)
[Jun 26 16:29:56][w1t]  reading w1 device 28-0000045d2497 returned 42.937000
[Jun 26 16:29:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:56][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:57][w1t]  read 21.875000 from /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=21875
)
[Jun 26 16:29:57][w1t]  reading w1 device 28-0000045d7eb0 returned 21.875000
[Jun 26 16:29:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:57][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:57][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:57][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951396777
[Jun 26 16:29:57][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951396777
[Jun 26 16:29:57][chn3] Adding reading to queue (value=1.00 ts=1466951396777)
[Jun 26 16:29:57][chn3] ==> number of tuples: 1
[Jun 26 16:29:57][chn3] compare: 1466951394940 1466951396777
[Jun 26 16:29:57][chn3] JSON request body: [ [ 1466951396777, 1 ] ]
[Jun 26 16:29:57][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:57][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:57][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#26)
[Jun 26 16:29:57][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:57][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:57][chn3] CURL: Sent '[ [ 1466951396777, 1 ] ]' bytes
[Jun 26 16:29:57][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:57][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:57][chn3] CURL: Received 26 bytes
[Jun 26 16:29:57][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:57][chn3] CURL: Closing connection 26
[Jun 26 16:29:57][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:57][w1t]  read 22.062000 from /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=22062
)
[Jun 26 16:29:57][w1t]  reading w1 device 28-000004a2845a returned 22.062000
[Jun 26 16:29:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:58][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:29:58][w1t]  read 12.000000 from /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=12000
)
[Jun 26 16:29:58][w1t]  reading w1 device 28-000004c913d5 returned 12.000000
[Jun 26 16:29:58][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:29:58][mtr3] Got 2 new readings from meter:
[Jun 26 16:29:58][mtr3] Reading: id=Power/StringItentifier: value=1962.92 ts=1466951398611
[Jun 26 16:29:58][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951398611
[Jun 26 16:29:58][chn3] Adding reading to queue (value=1.00 ts=1466951398611)
[Jun 26 16:29:58][chn3] ==> number of tuples: 1
[Jun 26 16:29:58][chn3] compare: 1466951396777 1466951398611
[Jun 26 16:29:58][chn3] JSON request body: [ [ 1466951398611, 1 ] ]
[Jun 26 16:29:58][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:29:58][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:29:58][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#27)
[Jun 26 16:29:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:58][chn3] Buffer dump (size=0): {}
[Jun 26 16:29:58][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:29:58][chn3] CURL: Sent '[ [ 1466951398611, 1 ] ]' bytes
[Jun 26 16:29:58][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:29:58][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:29:58][chn3] CURL: Received 26 bytes
[Jun 26 16:29:58][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:29:58][chn3] CURL: Closing connection 27
[Jun 26 16:29:58][chn3] CURL Request succeeded with code: 200
[Jun 26 16:29:59][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=12125
)
[Jun 26 16:29:59][w1t]  reading w1 device 28-000004c9583f returned 12.125000
[Jun 26 16:29:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:29:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:00][w1t]  read 11.812000 from /sys/bus/w1/devices/28-000004c963b9/w1_slave (t=11812
)
[Jun 26 16:30:00][w1t]  reading w1 device 28-000004c963b9 returned 11.812000
[Jun 26 16:30:00][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:00][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:00][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:00][mtr3] Reading: id=Power/StringItentifier: value=1962.92 ts=1466951400445
[Jun 26 16:30:00][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951400445
[Jun 26 16:30:00][chn3] Adding reading to queue (value=1.00 ts=1466951400445)
[Jun 26 16:30:00][chn3] ==> number of tuples: 1
[Jun 26 16:30:00][chn3] compare: 1466951398611 1466951400445
[Jun 26 16:30:00][chn3] JSON request body: [ [ 1466951400445, 1 ] ]
[Jun 26 16:30:00][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:00][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:00][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#28)
[Jun 26 16:30:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:00][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:00][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:00][chn3] CURL: Sent '[ [ 1466951400445, 1 ] ]' bytes
[Jun 26 16:30:00][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:00][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:00][chn3] CURL: Received 26 bytes
[Jun 26 16:30:00][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:00][chn3] CURL: Closing connection 28
[Jun 26 16:30:00][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:01][w1t]  read 12.187000 from /sys/bus/w1/devices/28-000004c969de/w1_slave (t=12187
)
[Jun 26 16:30:01][w1t]  reading w1 device 28-000004c969de returned 12.187000
[Jun 26 16:30:01][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:01][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:01][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:01][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:01][mtr2] Reading: id=Power/StringItentifier: value=309.84 ts=1466951401192
[Jun 26 16:30:01][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951401192
[Jun 26 16:30:01][chn2] Adding reading to queue (value=1.00 ts=1466951401192)
[Jun 26 16:30:01][chn2] ==> number of tuples: 1
[Jun 26 16:30:01][chn2] compare: 1466951389573 1466951401192
[Jun 26 16:30:01][chn2] JSON request body: [ [ 1466951401192, 1 ] ]
[Jun 26 16:30:01][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:01][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:01][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#29)
[Jun 26 16:30:01][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:01][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:01][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:01][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:01][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:01][chn2] CURL: Sent '[ [ 1466951401192, 1 ] ]' bytes
[Jun 26 16:30:01][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:01][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:01][chn2] CURL: Received 26 bytes
[Jun 26 16:30:01][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:01][chn2] CURL: Closing connection 29
[Jun 26 16:30:01][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:02][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c96a87/w1_slave (t=11750
)
[Jun 26 16:30:02][w1t]  reading w1 device 28-000004c96a87 returned 11.750000
[Jun 26 16:30:02][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:02][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:02][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:02][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:02][mtr3] Reading: id=Power/StringItentifier: value=1968.29 ts=1466951402274
[Jun 26 16:30:02][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951402274
[Jun 26 16:30:02][chn3] Adding reading to queue (value=1.00 ts=1466951402274)
[Jun 26 16:30:02][chn3] ==> number of tuples: 1
[Jun 26 16:30:02][chn3] compare: 1466951400445 1466951402274
[Jun 26 16:30:02][chn3] JSON request body: [ [ 1466951402274, 1 ] ]
[Jun 26 16:30:02][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:02][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:02][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#30)
[Jun 26 16:30:02][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:02][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:02][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:02][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:02][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:02][chn3] CURL: Sent '[ [ 1466951402274, 1 ] ]' bytes
[Jun 26 16:30:02][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:02][w1t]  read 24.000000 from /sys/bus/w1/devices/28-000004f2467e/w1_slave (t=24000
)
[Jun 26 16:30:02][w1t]  reading w1 device 28-000004f2467e returned 24.000000
[Jun 26 16:30:03][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:03][chn3] CURL: Received 26 bytes
[Jun 26 16:30:03][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:03][chn3] CURL: Closing connection 30
[Jun 26 16:30:03][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:03][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:03][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:03][w1t]  read 23.875000 from /sys/bus/w1/devices/28-000004f1c7c6/w1_slave (t=23875
)
[Jun 26 16:30:03][w1t]  reading w1 device 28-000004f1c7c6 returned 23.875000
[Jun 26 16:30:03][mtr5] Got 12 new readings from meter:
[Jun 26 16:30:03][mtr5] Reading: id=28-0000045c6924/StringItentifier: value=11.75 ts=1466951394591
[Jun 26 16:30:03][mtr5] Reading: id=28-0000045c5c7e/StringItentifier: value=13.44 ts=1466951395410
[Jun 26 16:30:03][mtr5] Reading: id=28-0000045d2497/StringItentifier: value=42.94 ts=1466951396230
[Jun 26 16:30:03][mtr5] Reading: id=28-0000045d7eb0/StringItentifier: value=21.88 ts=1466951397050
[Jun 26 16:30:03][mtr5] Reading: id=28-000004a2845a/StringItentifier: value=22.06 ts=1466951397875
[Jun 26 16:30:03][mtr5] Reading: id=28-000004c913d5/StringItentifier: value=12.00 ts=1466951398690
[Jun 26 16:30:03][mtr5] Reading: id=28-000004c9583f/StringItentifier: value=12.12 ts=1466951399540
[Jun 26 16:30:03][mtr5] Reading: id=28-000004c963b9/StringItentifier: value=11.81 ts=1466951400360
[Jun 26 16:30:03][mtr5] Reading: id=28-000004c969de/StringItentifier: value=12.19 ts=1466951401180
[Jun 26 16:30:03][mtr5] Reading: id=28-000004c96a87/StringItentifier: value=11.75 ts=1466951402003
[Jun 26 16:30:03][mtr5] Reading: id=28-000004f2467e/StringItentifier: value=24.00 ts=1466951402821
[Jun 26 16:30:03][mtr5] Reading: id=28-000004f1c7c6/StringItentifier: value=23.88 ts=1466951403646
[Jun 26 16:30:03][chn5] Adding reading to queue (value=13.44 ts=1466951395410)
[Jun 26 16:30:03][chn6] Adding reading to queue (value=21.88 ts=1466951397050)
[Jun 26 16:30:03][chn7] Adding reading to queue (value=22.06 ts=1466951397875)
[Jun 26 16:30:03][chn8] Adding reading to queue (value=42.94 ts=1466951396230)
[Jun 26 16:30:03][chn9] Adding reading to queue (value=23.88 ts=1466951403646)
[Jun 26 16:30:03][chn10]Adding reading to queue (value=24.00 ts=1466951402821)
[Jun 26 16:30:03][chn11]Adding reading to queue (value=12.19 ts=1466951401180)
[Jun 26 16:30:03][chn12]Adding reading to queue (value=11.75 ts=1466951402003)
[Jun 26 16:30:03][chn13]Adding reading to queue (value=12.12 ts=1466951399540)
[Jun 26 16:30:03][chn14]Adding reading to queue (value=11.81 ts=1466951400360)
[Jun 26 16:30:03][chn15]Adding reading to queue (value=12.00 ts=1466951398690)
[Jun 26 16:30:03][chn16]Adding reading to queue (value=11.75 ts=1466951394591)
[Jun 26 16:30:03][chn5] ==> number of tuples: 1
[Jun 26 16:30:03][chn5] compare: 1466951375358 1466951395410
[Jun 26 16:30:03][chn5] JSON request body: [ [ 1466951395410, 13.436999999999999 ] ]
[Jun 26 16:30:03][chn5] CURL: Hostname was found in DNS cache
[Jun 26 16:30:03][chn5] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:03][chn5] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#31)
[Jun 26 16:30:03][chn5] Buffer dump (size=0): {}
[Jun 26 16:30:03][chn5] CURL: Sent 41 bytes.. 
[Jun 26 16:30:03][chn6] ==> number of tuples: 1
[Jun 26 16:30:03][chn6] compare: 1466951376978 1466951397050
[Jun 26 16:30:03][chn5] CURL: Sent '[ [ 1466951395410, 13.436999999999999 ] ]' bytes
[Jun 26 16:30:03][chn5] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:03][chn6] Buffer dump (size=1): {21.8750,}
[Jun 26 16:30:03][chn7] ==> number of tuples: 1
[Jun 26 16:30:03][chn7] compare: 1466951377791 1466951397875
[Jun 26 16:30:03][chn7] Buffer dump (size=0): {}
[Jun 26 16:30:03][chn8] ==> number of tuples: 1
[Jun 26 16:30:03][chn8] compare: 1466951376168 1466951396230
[Jun 26 16:30:03][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:03][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:03][chn8] Buffer dump (size=0): {}
[Jun 26 16:30:03][chn9] ==> number of tuples: 1
[Jun 26 16:30:03][chn9] compare: 1466951383647 1466951403646
[Jun 26 16:30:03][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:03][chn9] Buffer dump (size=0): {}
[Jun 26 16:30:03][chn10]==> number of tuples: 1
[Jun 26 16:30:03][chn10]compare: 1466951382755 1466951402821
[Jun 26 16:30:03][chn10]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn11]==> number of tuples: 1
[Jun 26 16:30:03][chn11]compare: 1466951381060 1466951401180
[Jun 26 16:30:03][chn11]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn12]==> number of tuples: 1
[Jun 26 16:30:03][chn12]compare: 1466951381880 1466951402003
[Jun 26 16:30:03][chn12]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn13]==> number of tuples: 1
[Jun 26 16:30:03][chn13]compare: 1466951379428 1466951399540
[Jun 26 16:30:03][chn13]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn14]==> number of tuples: 1
[Jun 26 16:30:03][chn14]compare: 1466951380241 1466951400360
[Jun 26 16:30:03][chn14]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn15]==> number of tuples: 1
[Jun 26 16:30:03][chn15]compare: 1466951378608 1466951398690
[Jun 26 16:30:03][chn15]Buffer dump (size=0): {}
[Jun 26 16:30:03][chn16]==> number of tuples: 1
[Jun 26 16:30:03][chn16]compare: 1466951374548 1466951394591
[Jun 26 16:30:03][chn16]Buffer dump (size=0): {}
[Jun 26 16:30:03][mtr5] Next reading in 10 seconds
[Jun 26 16:30:03][chn5] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:03][chn5] CURL: Received 26 bytes
[Jun 26 16:30:03][chn5] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:03][chn5] CURL: Closing connection 31
[Jun 26 16:30:03][chn6] JSON request body: [ [ 1466951397050, 21.875 ] ]
[Jun 26 16:30:03][chn6] CURL: Hostname was found in DNS cache
[Jun 26 16:30:03][chn6] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:03][chn6] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#32)
[Jun 26 16:30:03][chn6] CURL: Sent 29 bytes.. 
[Jun 26 16:30:03][chn6] CURL: Sent '[ [ 1466951397050, 21.875 ] ]' bytes
[Jun 26 16:30:03][chn6] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:03][chn5] CURL Request succeeded with code: 200
[Jun 26 16:30:04][chn6] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn6] CURL: Received 26 bytes
[Jun 26 16:30:04][chn6] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn6] CURL: Closing connection 32
[Jun 26 16:30:04][chn7] JSON request body: [ [ 1466951397875, 22.062000000000001 ] ]
[Jun 26 16:30:04][chn7] CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn7] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn7] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#33)
[Jun 26 16:30:04][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:04][chn7] CURL: Sent 41 bytes.. 
[Jun 26 16:30:04][chn7] CURL: Sent '[ [ 1466951397875, 22.062000000000001 ] ]' bytes
[Jun 26 16:30:04][chn7] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:04][chn6] CURL Request succeeded with code: 200
[Jun 26 16:30:04][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:04][chn7] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn7] CURL: Received 26 bytes
[Jun 26 16:30:04][chn7] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn7] CURL: Closing connection 33
[Jun 26 16:30:04][chn8] JSON request body: [ [ 1466951396230, 42.936999999999998 ] ]
[Jun 26 16:30:04][chn8] CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn8] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn8] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#34)
[Jun 26 16:30:04][chn8] CURL: Sent 41 bytes.. 
[Jun 26 16:30:04][chn8] CURL: Sent '[ [ 1466951396230, 42.936999999999998 ] ]' bytes
[Jun 26 16:30:04][chn7] CURL Request succeeded with code: 200
[Jun 26 16:30:04][chn8] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:04][chn8] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn8] CURL: Received 26 bytes
[Jun 26 16:30:04][chn8] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn8] CURL: Closing connection 34
[Jun 26 16:30:04][chn9] JSON request body: [ [ 1466951403646, 23.875 ] ]
[Jun 26 16:30:04][chn9] CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn9] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn9] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#35)
[Jun 26 16:30:04][chn9] CURL: Sent 29 bytes.. 
[Jun 26 16:30:04][chn9] CURL: Sent '[ [ 1466951403646, 23.875 ] ]' bytes
[Jun 26 16:30:04][chn8] CURL Request succeeded with code: 200
[Jun 26 16:30:04][chn9] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:04][chn9] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn9] CURL: Received 26 bytes
[Jun 26 16:30:04][chn9] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn9] CURL: Closing connection 35
[Jun 26 16:30:04][chn10]JSON request body: [ [ 1466951402821, 24 ] ]
[Jun 26 16:30:04][chn10]CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn10]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn10]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#36)
[Jun 26 16:30:04][chn10]CURL: Sent 25 bytes.. 
[Jun 26 16:30:04][chn10]CURL: Sent '[ [ 1466951402821, 24 ] ]' bytes
[Jun 26 16:30:04][chn10]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:30:04][chn9] CURL Request succeeded with code: 200
[Jun 26 16:30:04][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:04][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:04][mtr3] Reading: id=Power/StringItentifier: value=1969.37 ts=1466951404102
[Jun 26 16:30:04][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951404102
[Jun 26 16:30:04][chn3] Adding reading to queue (value=1.00 ts=1466951404102)
[Jun 26 16:30:04][chn3] ==> number of tuples: 1
[Jun 26 16:30:04][chn3] compare: 1466951402274 1466951404102
[Jun 26 16:30:04][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:04][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:04][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:04][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:04][chn10]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn10]CURL: Received 26 bytes
[Jun 26 16:30:04][chn10]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn10]CURL: Closing connection 36
[Jun 26 16:30:04][chn14]JSON request body: [ [ 1466951400360, 11.811999999999999 ] ]
[Jun 26 16:30:04][chn14]CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn14]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn14]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#37)
[Jun 26 16:30:04][chn14]CURL: Sent 41 bytes.. 
[Jun 26 16:30:04][chn14]CURL: Sent '[ [ 1466951400360, 11.811999999999999 ] ]' bytes
[Jun 26 16:30:04][chn14]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:04][chn10]CURL Request succeeded with code: 200
[Jun 26 16:30:04][chn14]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:04][chn14]CURL: Received 26 bytes
[Jun 26 16:30:04][chn14]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:04][chn14]CURL: Closing connection 37
[Jun 26 16:30:04][chn3] JSON request body: [ [ 1466951404102, 1 ] ]
[Jun 26 16:30:04][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:04][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:04][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#38)
[Jun 26 16:30:04][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:04][chn3] CURL: Sent '[ [ 1466951404102, 1 ] ]' bytes
[Jun 26 16:30:04][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:04][chn14]CURL Request succeeded with code: 200
[Jun 26 16:30:05][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:05][chn3] CURL: Received 26 bytes
[Jun 26 16:30:05][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:05][chn3] CURL: Closing connection 38
[Jun 26 16:30:05][chn11]JSON request body: [ [ 1466951401180, 12.186999999999999 ] ]
[Jun 26 16:30:05][chn11]CURL: Hostname was found in DNS cache
[Jun 26 16:30:05][chn11]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:05][chn11]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#39)
[Jun 26 16:30:05][chn11]CURL: Sent 41 bytes.. 
[Jun 26 16:30:05][chn11]CURL: Sent '[ [ 1466951401180, 12.186999999999999 ] ]' bytes
[Jun 26 16:30:05][chn11]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:05][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:05][chn11]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:05][chn11]CURL: Received 26 bytes
[Jun 26 16:30:05][chn11]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:05][chn11]CURL: Closing connection 39
[Jun 26 16:30:05][chn12]JSON request body: [ [ 1466951402003, 11.75 ] ]
[Jun 26 16:30:05][chn12]CURL: Hostname was found in DNS cache
[Jun 26 16:30:05][chn12]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:05][chn12]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#40)
[Jun 26 16:30:05][chn12]CURL: Sent 28 bytes.. 
[Jun 26 16:30:05][chn12]CURL: Sent '[ [ 1466951402003, 11.75 ] ]' bytes
[Jun 26 16:30:05][chn12]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:30:05][chn11]CURL Request succeeded with code: 200
[Jun 26 16:30:05][chn12]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:05][chn12]CURL: Received 26 bytes
[Jun 26 16:30:05][chn12]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:05][chn12]CURL: Closing connection 40
[Jun 26 16:30:05][chn13]JSON request body: [ [ 1466951399540, 12.125 ] ]
[Jun 26 16:30:05][chn13]CURL: Hostname was found in DNS cache
[Jun 26 16:30:05][chn13]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:05][chn13]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#41)
[Jun 26 16:30:05][chn13]CURL: Sent 29 bytes.. 
[Jun 26 16:30:05][chn13]CURL: Sent '[ [ 1466951399540, 12.125 ] ]' bytes
[Jun 26 16:30:05][chn13]CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:05][chn12]CURL Request succeeded with code: 200
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:05][chn13]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:05][chn13]CURL: Received 26 bytes
[Jun 26 16:30:05][chn13]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:05][chn13]CURL: Closing connection 41
[Jun 26 16:30:05][chn15]JSON request body: [ [ 1466951398690, 12 ] ]
[Jun 26 16:30:05][chn15]CURL: Hostname was found in DNS cache
[Jun 26 16:30:05][chn15]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:05][chn15]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#42)
[Jun 26 16:30:05][chn15]CURL: Sent 25 bytes.. 
[Jun 26 16:30:05][chn15]CURL: Sent '[ [ 1466951398690, 12 ] ]' bytes
[Jun 26 16:30:05][chn15]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:30:05][chn13]CURL Request succeeded with code: 200
[Jun 26 16:30:05][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:06][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:06][chn15]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:06][chn15]CURL: Received 26 bytes
[Jun 26 16:30:06][chn15]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:06][chn15]CURL: Closing connection 42
[Jun 26 16:30:06][chn16]JSON request body: [ [ 1466951394591, 11.75 ] ]
[Jun 26 16:30:06][chn16]CURL: Hostname was found in DNS cache
[Jun 26 16:30:06][chn16]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:06][chn16]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#43)
[Jun 26 16:30:06][chn16]CURL: Sent 28 bytes.. 
[Jun 26 16:30:06][chn16]CURL: Sent '[ [ 1466951394591, 11.75 ] ]' bytes
[Jun 26 16:30:06][chn16]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:30:06][chn15]CURL Request succeeded with code: 200
[Jun 26 16:30:06][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:06][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:06][mtr3] Reading: id=Power/StringItentifier: value=1962.92 ts=1466951405936
[Jun 26 16:30:06][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951405936
[Jun 26 16:30:06][chn3] Adding reading to queue (value=1.00 ts=1466951405936)
[Jun 26 16:30:06][chn3] ==> number of tuples: 1
[Jun 26 16:30:06][chn3] compare: 1466951404102 1466951405936
[Jun 26 16:30:06][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:06][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:06][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:06][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:06][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:07][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:07][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:07][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:07][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:07][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:08][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:08][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:08][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:08][mtr3] Reading: id=Power/StringItentifier: value=1968.29 ts=1466951407765
[Jun 26 16:30:08][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951407765
[Jun 26 16:30:08][chn3] Adding reading to queue (value=1.00 ts=1466951407765)
[Jun 26 16:30:08][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:08][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:08][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:08][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:08][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:09][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:09][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:09][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:09][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:09][mtr3] Reading: id=Power/StringItentifier: value=1973.68 ts=1466951409589
[Jun 26 16:30:09][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951409589
[Jun 26 16:30:09][chn3] Adding reading to queue (value=1.00 ts=1466951409589)
[Jun 26 16:30:09][chn3] Buffer dump (size=2): {1.0000,1.0000,}
[Jun 26 16:30:09][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:09][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:09][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:10][chn16]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:10][chn16]CURL: Received 26 bytes
[Jun 26 16:30:10][chn16]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:10][chn16]CURL: Closing connection 43
[Jun 26 16:30:10][chn3] JSON request body: [ [ 1466951405936, 1 ] ]
[Jun 26 16:30:10][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:10][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:10][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#44)
[Jun 26 16:30:10][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:10][chn3] CURL: Sent '[ [ 1466951405936, 1 ] ]' bytes
[Jun 26 16:30:10][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:10][chn16]CURL Request succeeded with code: 200
[Jun 26 16:30:10][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:10][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:10][chn3] CURL: Received 26 bytes
[Jun 26 16:30:10][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:10][chn3] CURL: Closing connection 44
[Jun 26 16:30:10][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:10][chn3] ==> number of tuples: 2
[Jun 26 16:30:10][chn3] compare: 1466951405936 1466951407765
[Jun 26 16:30:10][chn3] compare: 1466951407765 1466951409589
[Jun 26 16:30:10][chn3] JSON request body: [ [ 1466951407765, 1 ], [ 1466951409589, 1 ] ]
[Jun 26 16:30:10][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:10][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:10][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#45)
[Jun 26 16:30:10][chn3] CURL: Sent 46 bytes.. 
[Jun 26 16:30:10][chn3] CURL: Sent '[ [ 1466951407765, 1 ], [ 1466951409589, 1 ] ]' bytes
[Jun 26 16:30:10][chn3] CURL: upload completely sent off: 46 out of 46 bytes
[Jun 26 16:30:10][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:10][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:10][chn3] CURL: Received 26 bytes
[Jun 26 16:30:10][chn3] CURL: Received '{"version":"0.3","rows":2}' bytes
[Jun 26 16:30:10][chn3] CURL: Closing connection 45
[Jun 26 16:30:10][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:10][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:10][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:10][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:11][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:11][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:11][mtr2] Reading: id=Power/StringItentifier: value=357.46 ts=1466951411263
[Jun 26 16:30:11][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951411263
[Jun 26 16:30:11][chn2] Adding reading to queue (value=1.00 ts=1466951411263)
[Jun 26 16:30:11][chn2] ==> number of tuples: 1
[Jun 26 16:30:11][chn2] compare: 1466951401192 1466951411263
[Jun 26 16:30:11][chn2] JSON request body: [ [ 1466951411263, 1 ] ]
[Jun 26 16:30:11][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:11][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:11][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:11][mtr3] Reading: id=Power/StringItentifier: value=1969.37 ts=1466951411417
[Jun 26 16:30:11][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951411417
[Jun 26 16:30:11][chn3] Adding reading to queue (value=1.00 ts=1466951411417)
[Jun 26 16:30:11][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:11][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:11][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#46)
[Jun 26 16:30:11][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:11][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:11][chn2] CURL: Sent '[ [ 1466951411263, 1 ] ]' bytes
[Jun 26 16:30:11][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:11][chn3] ==> number of tuples: 1
[Jun 26 16:30:11][chn3] compare: 1466951409589 1466951411417
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:11][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:11][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:11][chn2] CURL: Received 26 bytes
[Jun 26 16:30:11][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:11][chn2] CURL: Closing connection 46
[Jun 26 16:30:11][chn3] JSON request body: [ [ 1466951411417, 1 ] ]
[Jun 26 16:30:11][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:11][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:11][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#47)
[Jun 26 16:30:11][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:11][chn3] CURL: Sent '[ [ 1466951411417, 1 ] ]' bytes
[Jun 26 16:30:11][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:11][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:11][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:11][chn3] CURL: Received 26 bytes
[Jun 26 16:30:11][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:11][chn3] CURL: Closing connection 47
[Jun 26 16:30:11][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:12][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:12][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:12][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:12][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:12][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:13][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:13][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:13][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:13][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:13][mtr3] Reading: id=Power/StringItentifier: value=1970.44 ts=1466951413244
[Jun 26 16:30:13][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951413244
[Jun 26 16:30:13][chn3] Adding reading to queue (value=1.00 ts=1466951413244)
[Jun 26 16:30:13][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:13][chn3] ==> number of tuples: 1
[Jun 26 16:30:13][chn3] compare: 1466951411417 1466951413244
[Jun 26 16:30:13][chn3] JSON request body: [ [ 1466951413244, 1 ] ]
[Jun 26 16:30:13][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:13][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:13][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#48)
[Jun 26 16:30:13][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:13][chn3] CURL: Sent '[ [ 1466951413244, 1 ] ]' bytes
[Jun 26 16:30:13][chn3] [Jun 26 16:30:13][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:13][S0]   MeterS0:HWIF_GPIO:first poll returned 0
CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:13][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:13][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:13][chn3] CURL: Received 26 bytes
[Jun 26 16:30:13][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:13][chn3] CURL: Closing connection 48
[Jun 26 16:30:13][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:14][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:14][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:14][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:14][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:14][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:14][w1t]  read 11.687000 from /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=11687
)
[Jun 26 16:30:14][w1t]  reading w1 device 28-0000045c6924 returned 11.687000
[Jun 26 16:30:15][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:15][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:15][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:15][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:15][mtr3] Reading: id=Power/StringItentifier: value=1969.37 ts=1466951415072
[Jun 26 16:30:15][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951415072
[Jun 26 16:30:15][chn3] Adding reading to queue (value=1.00 ts=1466951415072)
[Jun 26 16:30:15][chn3] ==> number of tuples: 1
[Jun 26 16:30:15][chn3] compare: 1466951413244 1466951415072
[Jun 26 16:30:15][chn3] JSON request body: [ [ 1466951415072, 1 ] ]
[Jun 26 16:30:15][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:15][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:15][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#49)
[Jun 26 16:30:15][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:15][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:15][chn3] CURL: Sent '[ [ 1466951415072, 1 ] ]' bytes
[Jun 26 16:30:15][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:15][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:15][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:15][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:15][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:15][chn3] CURL: Received 26 bytes
[Jun 26 16:30:15][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:15][chn3] CURL: Closing connection 49
[Jun 26 16:30:15][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:15][w1t]  read 13.500000 from /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=13500
)
[Jun 26 16:30:15][w1t]  reading w1 device 28-0000045c5c7e returned 13.500000
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:16][w1t]  read 42.937000 from /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=42937
)
[Jun 26 16:30:16][w1t]  reading w1 device 28-0000045d2497 returned 42.937000
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:16][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:17][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:17][w1t]  read 21.875000 from /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=21875
)
[Jun 26 16:30:17][w1t]  reading w1 device 28-0000045d7eb0 returned 21.875000
[Jun 26 16:30:17][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:17][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:17][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951416909
[Jun 26 16:30:17][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951416909
[Jun 26 16:30:17][chn3] Adding reading to queue (value=1.00 ts=1466951416909)
[Jun 26 16:30:17][chn3] ==> number of tuples: 1
[Jun 26 16:30:17][chn3] compare: 1466951415072 1466951416909
[Jun 26 16:30:17][chn3] JSON request body: [ [ 1466951416909, 1 ] ]
[Jun 26 16:30:17][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:17][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:17][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#50)
[Jun 26 16:30:17][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:17][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:17][chn3] CURL: Sent '[ [ 1466951416909, 1 ] ]' bytes
[Jun 26 16:30:17][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:17][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:17][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:17][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:17][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:17][chn3] CURL: Received 26 bytes
[Jun 26 16:30:17][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:17][chn3] CURL: Closing connection 50
[Jun 26 16:30:17][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:17][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:18][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:18][w1t]  read 22.062000 from /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=22062
)
[Jun 26 16:30:18][w1t]  reading w1 device 28-000004a2845a returned 22.062000
[Jun 26 16:30:18][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:18][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:18][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:18][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:19][w1t]  read 12.000000 from /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=12000
)
[Jun 26 16:30:19][w1t]  reading w1 device 28-000004c913d5 returned 12.000000
[Jun 26 16:30:19][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:19][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:19][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:19][mtr3] Reading: id=Power/StringItentifier: value=1955.46 ts=1466951418750
[Jun 26 16:30:19][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951418750
[Jun 26 16:30:19][chn3] Adding reading to queue (value=1.00 ts=1466951418750)
[Jun 26 16:30:19][chn3] ==> number of tuples: 1
[Jun 26 16:30:19][chn3] compare: 1466951416909 1466951418750
[Jun 26 16:30:19][chn3] JSON request body: [ [ 1466951418750, 1 ] ]
[Jun 26 16:30:19][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:19][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:19][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#51)
[Jun 26 16:30:19][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:19][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:19][chn3] CURL: Sent '[ [ 1466951418750, 1 ] ]' bytes
[Jun 26 16:30:19][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:19][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:19][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:19][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:19][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:19][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=12125
)
[Jun 26 16:30:19][w1t]  reading w1 device 28-000004c9583f returned 12.125000
[Jun 26 16:30:20][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:20][chn3] CURL: Received 26 bytes
[Jun 26 16:30:20][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:20][chn3] CURL: Closing connection 51
[Jun 26 16:30:20][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:20][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:20][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:20][mtr3] Reading: id=Power/StringItentifier: value=1969.37 ts=1466951420578
[Jun 26 16:30:20][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951420578
[Jun 26 16:30:20][chn3] Adding reading to queue (value=1.00 ts=1466951420578)
[Jun 26 16:30:20][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:20][chn3] ==> number of tuples: 1
[Jun 26 16:30:20][chn3] compare: 1466951418750 1466951420578
[Jun 26 16:30:20][chn3] JSON request body: [ [ 1466951420578, 1 ] ]
[Jun 26 16:30:20][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:20][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:20][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#52)
[Jun 26 16:30:20][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:20][chn3] CURL: Sent '[ [ 1466951420578, 1 ] ]' bytes
[Jun 26 16:30:20][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:20][w1t]  read 11.812000 from /sys/bus/w1/devices/28-000004c963b9/w1_slave (t=11812
)
[Jun 26 16:30:20][w1t]  reading w1 device 28-000004c963b9 returned 11.812000
[Jun 26 16:30:20][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:21][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:21][chn3] CURL: Received 26 bytes
[Jun 26 16:30:21][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:21][chn3] CURL: Closing connection 52
[Jun 26 16:30:21][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:21][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:21][w1t]  read 12.187000 from /sys/bus/w1/devices/28-000004c969de/w1_slave (t=12187
)
[Jun 26 16:30:21][w1t]  reading w1 device 28-000004c969de returned 12.187000
[Jun 26 16:30:21][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:21][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:21][mtr2] Reading: id=Power/StringItentifier: value=370.41 ts=1466951420982
[Jun 26 16:30:21][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951420982
[Jun 26 16:30:21][chn2] Adding reading to queue (value=1.00 ts=1466951420982)
[Jun 26 16:30:21][chn2] ==> number of tuples: 1
[Jun 26 16:30:21][chn2] compare: 1466951411263 1466951420982
[Jun 26 16:30:21][chn2] JSON request body: [ [ 1466951420982, 1 ] ]
[Jun 26 16:30:21][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:21][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:21][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#53)
[Jun 26 16:30:21][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:21][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:21][chn2] CURL: Sent '[ [ 1466951420982, 1 ] ]' bytes
[Jun 26 16:30:21][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:21][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:21][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:21][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:21][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:21][chn2] CURL: Received 26 bytes
[Jun 26 16:30:21][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:21][chn2] CURL: Closing connection 53
[Jun 26 16:30:21][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:21][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:22][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:22][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c96a87/w1_slave (t=11750
)
[Jun 26 16:30:22][w1t]  reading w1 device 28-000004c96a87 returned 11.750000
[Jun 26 16:30:22][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:22][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:22][mtr3] Reading: id=Power/StringItentifier: value=1963.99 ts=1466951422411
[Jun 26 16:30:22][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951422411
[Jun 26 16:30:22][chn3] Adding reading to queue (value=1.00 ts=1466951422411)
[Jun 26 16:30:22][chn3] ==> number of tuples: 1
[Jun 26 16:30:22][chn3] compare: 1466951420578 1466951422411
[Jun 26 16:30:22][chn3] JSON request body: [ [ 1466951422411, 1 ] ]
[Jun 26 16:30:22][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:22][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:22][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#54)
[Jun 26 16:30:22][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:22][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:22][chn3] CURL: Sent '[ [ 1466951422411, 1 ] ]' bytes
[Jun 26 16:30:22][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:22][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:22][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:22][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:22][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:22][chn3] CURL: Received 26 bytes
[Jun 26 16:30:22][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:22][chn3] CURL: Closing connection 54
[Jun 26 16:30:22][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:22][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:23][w1t]  read 24.000000 from /sys/bus/w1/devices/28-000004f2467e/w1_slave (t=24000
)
[Jun 26 16:30:23][w1t]  reading w1 device 28-000004f2467e returned 24.000000
[Jun 26 16:30:23][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:23][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:23][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:23][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:23][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:24][w1t]  read 23.875000 from /sys/bus/w1/devices/28-000004f1c7c6/w1_slave (t=23875
)
[Jun 26 16:30:24][w1t]  reading w1 device 28-000004f1c7c6 returned 23.875000
[Jun 26 16:30:24][mtr5] Got 12 new readings from meter:
[Jun 26 16:30:24][mtr5] Reading: id=28-0000045c6924/StringItentifier: value=11.69 ts=1466951414788
[Jun 26 16:30:24][mtr5] Reading: id=28-0000045c5c7e/StringItentifier: value=13.50 ts=1466951415866
[Jun 26 16:30:24][mtr5] Reading: id=28-0000045d2497/StringItentifier: value=42.94 ts=1466951416680
[Jun 26 16:30:24][mtr5] Reading: id=28-0000045d7eb0/StringItentifier: value=21.88 ts=1466951417505
[Jun 26 16:30:24][mtr5] Reading: id=28-000004a2845a/StringItentifier: value=22.06 ts=1466951418340
[Jun 26 16:30:24][mtr5] Reading: id=28-000004c913d5/StringItentifier: value=12.00 ts=1466951419160
[Jun 26 16:30:24][mtr5] Reading: id=28-000004c9583f/StringItentifier: value=12.12 ts=1466951419980
[Jun 26 16:30:24][mtr5] Reading: id=28-000004c963b9/StringItentifier: value=11.81 ts=1466951420801
[Jun 26 16:30:24][mtr5] Reading: id=28-000004c969de/StringItentifier: value=12.19 ts=1466951421620
[Jun 26 16:30:24][mtr5] Reading: id=28-000004c96a87/StringItentifier: value=11.75 ts=1466951422441
[Jun 26 16:30:24][mtr5] Reading: id=28-000004f2467e/StringItentifier: value=24.00 ts=1466951423262
[Jun 26 16:30:24][mtr5] Reading: id=28-000004f1c7c6/StringItentifier: value=23.88 ts=1466951424104
[Jun 26 16:30:24][chn5] Adding reading to queue (value=13.50 ts=1466951415866)
[Jun 26 16:30:24][chn6] Adding reading to queue (value=21.88 ts=1466951417505)
[Jun 26 16:30:24][chn7] Adding reading to queue (value=22.06 ts=1466951418340)
[Jun 26 16:30:24][chn8] Adding reading to queue (value=42.94 ts=1466951416680)
[Jun 26 16:30:24][chn9] Adding reading to queue (value=23.88 ts=1466951424104)
[Jun 26 16:30:24][chn10]Adding reading to queue (value=24.00 ts=1466951423262)
[Jun 26 16:30:24][chn11]Adding reading to queue (value=12.19 ts=1466951421620)
[Jun 26 16:30:24][chn12]Adding reading to queue (value=11.75 ts=1466951422441)
[Jun 26 16:30:24][chn13]Adding reading to queue (value=12.12 ts=1466951419980)
[Jun 26 16:30:24][chn14]Adding reading to queue (value=11.81 ts=1466951420801)
[Jun 26 16:30:24][chn15]Adding reading to queue (value=12.00 ts=1466951419160)
[Jun 26 16:30:24][chn16]Adding reading to queue (value=11.69 ts=1466951414788)
[Jun 26 16:30:24][chn5] ==> number of tuples: 1
[Jun 26 16:30:24][chn5] compare: 1466951395410 1466951415866
[Jun 26 16:30:24][chn5] JSON request body: [ [ 1466951415866, 13.5 ] ]
[Jun 26 16:30:24][chn5] CURL: Hostname was found in DNS cache
[Jun 26 16:30:24][chn5] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:24][chn5] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#55)
[Jun 26 16:30:24][chn5] Buffer dump (size=0): {}
[Jun 26 16:30:24][chn5] CURL: Sent 27 bytes.. 
[Jun 26 16:30:24][chn6] ==> number of tuples: 1
[Jun 26 16:30:24][chn6] compare: 1466951397050 1466951417505
[Jun 26 16:30:24][chn5] CURL: Sent '[ [ 1466951415866, 13.5 ] ]' bytes
[Jun 26 16:30:24][chn6] Buffer dump (size=1): {21.8750,}
[Jun 26 16:30:24][chn7] ==> number of tuples: 1
[Jun 26 16:30:24][chn7] compare: 1466951397875 1466951418340
[Jun 26 16:30:24][chn5] CURL: upload completely sent off: 27 out of 27 bytes
[Jun 26 16:30:24][chn7] Buffer dump (size=0): {}
[Jun 26 16:30:24][chn8] ==> number of tuples: 1
[Jun 26 16:30:24][chn8] compare: 1466951396230 1466951416680
[Jun 26 16:30:24][chn8] Buffer dump (size=0): {}
[Jun 26 16:30:24][chn9] ==> number of tuples: 1
[Jun 26 16:30:24][chn9] compare: 1466951403646 1466951424104
[Jun 26 16:30:24][chn9] Buffer dump (size=0): {}
[Jun 26 16:30:24][chn10]==> number of tuples: 1
[Jun 26 16:30:24][chn10]compare: 1466951402821 1466951423262
[Jun 26 16:30:24][chn10]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn11]==> number of tuples: 1
[Jun 26 16:30:24][chn11]compare: 1466951401180 1466951421620
[Jun 26 16:30:24][chn11]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn12]==> number of tuples: 1
[Jun 26 16:30:24][chn12]compare: 1466951402003 1466951422441
[Jun 26 16:30:24][chn12]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn13]==> number of tuples: 1
[Jun 26 16:30:24][chn13]compare: 1466951399540 1466951419980
[Jun 26 16:30:24][chn13]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn14]==> number of tuples: 1
[Jun 26 16:30:24][chn14]compare: 1466951400360 1466951420801
[Jun 26 16:30:24][chn14]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn15]==> number of tuples: 1
[Jun 26 16:30:24][chn15]compare: 1466951398690 1466951419160
[Jun 26 16:30:24][chn15]Buffer dump (size=0): {}
[Jun 26 16:30:24][chn16]==> number of tuples: 1
[Jun 26 16:30:24][chn16]compare: 1466951394591 1466951414788
[Jun 26 16:30:24][chn16]Buffer dump (size=0): {}
[Jun 26 16:30:24][mtr5] Next reading in 10 seconds
[Jun 26 16:30:24][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:24][chn5] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:24][chn5] CURL: Received 26 bytes
[Jun 26 16:30:24][chn5] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:24][chn5] CURL: Closing connection 55
[Jun 26 16:30:24][chn6] JSON request body: [ [ 1466951417505, 21.875 ] ]
[Jun 26 16:30:24][chn6] CURL: Hostname was found in DNS cache
[Jun 26 16:30:24][chn6] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:24][chn6] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#56)
[Jun 26 16:30:24][chn6] CURL: Sent 29 bytes.. 
[Jun 26 16:30:24][chn6] CURL: Sent '[ [ 1466951417505, 21.875 ] ]' bytes
[Jun 26 16:30:24][chn6] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:24][chn5] CURL Request succeeded with code: 200
[Jun 26 16:30:24][chn6] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:24][chn6] CURL: Received 26 bytes
[Jun 26 16:30:24][chn6] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:24][chn6] CURL: Closing connection 56
[Jun 26 16:30:24][chn7] JSON request body: [ [ 1466951418340, 22.062000000000001 ] ]
[Jun 26 16:30:24][chn7] CURL: Hostname was found in DNS cache
[Jun 26 16:30:24][chn7] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:24][chn7] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#57)
[Jun 26 16:30:24][chn7] CURL: Sent 41 bytes.. 
[Jun 26 16:30:24][chn7] CURL: Sent '[ [ 1466951418340, 22.062000000000001 ] ]' bytes
[Jun 26 16:30:24][chn7] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:24][chn6] CURL Request succeeded with code: 200
[Jun 26 16:30:24][chn7] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:24][chn7] CURL: Received 26 bytes
[Jun 26 16:30:24][chn7] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:24][chn7] CURL: Closing connection 57
[Jun 26 16:30:24][chn8] JSON request body: [ [ 1466951416680, 42.936999999999998 ] ]
[Jun 26 16:30:24][chn8] CURL: Hostname was found in DNS cache
[Jun 26 16:30:24][chn8] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:24][chn8] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#58)
[Jun 26 16:30:24][chn8] CURL: Sent 41 bytes.. 
[Jun 26 16:30:24][chn8] CURL: Sent '[ [ 1466951416680, 42.936999999999998 ] ]' bytes
[Jun 26 16:30:24][chn8] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:24][chn7] CURL Request succeeded with code: 200
[Jun 26 16:30:24][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:24][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:24][mtr3] Reading: id=Power/StringItentifier: value=1966.14 ts=1466951424242
[Jun 26 16:30:24][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951424242
[Jun 26 16:30:24][chn3] Adding reading to queue (value=1.00 ts=1466951424242)
[Jun 26 16:30:24][chn3] ==> number of tuples: 1
[Jun 26 16:30:24][chn3] compare: 1466951422411 1466951424242
[Jun 26 16:30:24][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:24][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:24][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:24][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:24][chn8] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:24][chn8] CURL: Received 26 bytes
[Jun 26 16:30:24][chn8] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:24][chn8] CURL: Closing connection 58
[Jun 26 16:30:24][chn9] JSON request body: [ [ 1466951424104, 23.875 ] ]
[Jun 26 16:30:24][chn9] CURL: Hostname was found in DNS cache
[Jun 26 16:30:24][chn9] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:24][chn9] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#59)
[Jun 26 16:30:24][chn9] CURL: Sent 29 bytes.. 
[Jun 26 16:30:24][chn9] CURL: Sent '[ [ 1466951424104, 23.875 ] ]' bytes
[Jun 26 16:30:24][chn9] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:24][chn8] CURL Request succeeded with code: 200
[Jun 26 16:30:24][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][chn9] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn9] CURL: Received 26 bytes
[Jun 26 16:30:25][chn9] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][chn9] CURL: Closing connection 59
[Jun 26 16:30:25][chn3] JSON request body: [ [ 1466951424242, 1 ] ]
[Jun 26 16:30:25][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#60)
[Jun 26 16:30:25][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:25][chn3] CURL: Sent '[ [ 1466951424242, 1 ] ]' bytes
[Jun 26 16:30:25][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:25][chn9] CURL Request succeeded with code: 200
[Jun 26 16:30:25][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn3] CURL: Received 26 bytes
[Jun 26 16:30:25][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][chn3] CURL: Closing connection 60
[Jun 26 16:30:25][chn10]JSON request body: [ [ 1466951423262, 24 ] ]
[Jun 26 16:30:25][chn10]CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn10]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn10]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#61)
[Jun 26 16:30:25][chn10]CURL: Sent 25 bytes.. 
[Jun 26 16:30:25][chn10]CURL: Sent '[ [ 1466951423262, 24 ] ]' bytes
[Jun 26 16:30:25][chn10]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:30:25][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:25][chn10]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn10]CURL: Received 26 bytes
[Jun 26 16:30:25][chn10]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][chn10]CURL: Closing connection 61
[Jun 26 16:30:25][chn11]JSON request body: [ [ 1466951421620, 12.186999999999999 ] ]
[Jun 26 16:30:25][chn11]CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn11]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn11]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#62)
[Jun 26 16:30:25][chn11]CURL: Sent 41 bytes.. 
[Jun 26 16:30:25][chn11]CURL: Sent '[ [ 1466951421620, 12.186999999999999 ] ]' bytes
[Jun 26 16:30:25][chn11]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:25][chn10]CURL Request succeeded with code: 200
[Jun 26 16:30:25][chn11]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn11]CURL: Received 26 bytes
[Jun 26 16:30:25][chn11]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][chn11]CURL: Closing connection 62
[Jun 26 16:30:25][chn12]JSON request body: [ [ 1466951422441, 11.75 ] ]
[Jun 26 16:30:25][chn12]CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn12]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn12]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#63)
[Jun 26 16:30:25][chn12]CURL: Sent 28 bytes.. 
[Jun 26 16:30:25][chn12]CURL: Sent '[ [ 1466951422441, 11.75 ] ]' bytes
[Jun 26 16:30:25][chn12]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:30:25][chn11]CURL Request succeeded with code: 200
[Jun 26 16:30:25][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][chn12]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn12]CURL: Received 26 bytes
[Jun 26 16:30:25][chn12]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][chn12]CURL: Closing connection 63
[Jun 26 16:30:25][chn13]JSON request body: [ [ 1466951419980, 12.125 ] ]
[Jun 26 16:30:25][chn13]CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn13]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn13]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#64)
[Jun 26 16:30:25][chn13]CURL: Sent 29 bytes.. 
[Jun 26 16:30:25][chn13]CURL: Sent '[ [ 1466951419980, 12.125 ] ]' bytes
[Jun 26 16:30:25][chn13]CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:25][chn12]CURL Request succeeded with code: 200
[Jun 26 16:30:25][chn13]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:25][chn13]CURL: Received 26 bytes
[Jun 26 16:30:25][chn13]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:25][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:25][chn13]CURL: Closing connection 64
[Jun 26 16:30:25][chn14]JSON request body: [ [ 1466951420801, 11.811999999999999 ] ]
[Jun 26 16:30:25][chn14]CURL: Hostname was found in DNS cache
[Jun 26 16:30:25][chn14]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:25][chn14]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#65)
[Jun 26 16:30:25][chn14]CURL: Sent 41 bytes.. 
[Jun 26 16:30:26][chn14]CURL: Sent '[ [ 1466951420801, 11.811999999999999 ] ]' bytes
[Jun 26 16:30:26][chn14]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:26][chn13]CURL Request succeeded with code: 200
[Jun 26 16:30:26][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:26][chn14]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:26][chn14]CURL: Received 26 bytes
[Jun 26 16:30:26][chn14]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:26][chn14]CURL: Closing connection 65
[Jun 26 16:30:26][chn15]JSON request body: [ [ 1466951419160, 12 ] ]
[Jun 26 16:30:26][chn15]CURL: Hostname was found in DNS cache
[Jun 26 16:30:26][chn15]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:26][chn15]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#66)
[Jun 26 16:30:26][chn15]CURL: Sent 25 bytes.. 
[Jun 26 16:30:26][chn15]CURL: Sent '[ [ 1466951419160, 12 ] ]' bytes
[Jun 26 16:30:26][chn15]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:30:26][chn14]CURL Request succeeded with code: 200
[Jun 26 16:30:26][chn15]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:26][chn15]CURL: Received 26 bytes
[Jun 26 16:30:26][chn15]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:26][chn15]CURL: Closing connection 66
[Jun 26 16:30:26][chn16]JSON request body: [ [ 1466951414788, 11.686999999999999 ] ]
[Jun 26 16:30:26][chn16]CURL: Hostname was found in DNS cache
[Jun 26 16:30:26][chn16]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:26][chn16]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#67)
[Jun 26 16:30:26][chn16]CURL: Sent 41 bytes.. 
[Jun 26 16:30:26][chn16]CURL: Sent '[ [ 1466951414788, 11.686999999999999 ] ]' bytes
[Jun 26 16:30:26][chn16]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:26][chn15]CURL Request succeeded with code: 200
[Jun 26 16:30:26][chn16]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:26][chn16]CURL: Received 26 bytes
[Jun 26 16:30:26][chn16]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:26][chn16]CURL: Closing connection 67
[Jun 26 16:30:26][chn16]CURL Request succeeded with code: 200
[Jun 26 16:30:26][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:26][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:26][mtr3] Reading: id=Power/StringItentifier: value=1967.21 ts=1466951426072
[Jun 26 16:30:26][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951426072
[Jun 26 16:30:26][chn3] Adding reading to queue (value=1.00 ts=1466951426072)
[Jun 26 16:30:26][chn3] ==> number of tuples: 1
[Jun 26 16:30:26][chn3] compare: 1466951424242 1466951426072
[Jun 26 16:30:26][chn3] JSON request body: [ [ 1466951426072, 1 ] ]
[Jun 26 16:30:26][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:26][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:26][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#68)
[Jun 26 16:30:26][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:26][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:26][chn3] CURL: Sent '[ [ 1466951426072, 1 ] ]' bytes
[Jun 26 16:30:26][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:26][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:26][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:26][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:26][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:26][chn3] CURL: Received 26 bytes
[Jun 26 16:30:26][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:26][chn3] CURL: Closing connection 68
[Jun 26 16:30:26][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:26][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:27][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:28][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:28][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:28][mtr3] Reading: id=Power/StringItentifier: value=1951.22 ts=1466951427917
[Jun 26 16:30:28][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951427917
[Jun 26 16:30:28][chn3] Adding reading to queue (value=1.00 ts=1466951427917)
[Jun 26 16:30:28][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:28][chn3] ==> number of tuples: 1
[Jun 26 16:30:28][chn3] compare: 1466951426072 1466951427917
[Jun 26 16:30:28][chn3] JSON request body: [ [ 1466951427917, 1 ] ]
[Jun 26 16:30:28][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:28][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:28][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#69)
[Jun 26 16:30:28][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:28][chn3] CURL: Sent '[ [ 1466951427917, 1 ] ]' bytes
[Jun 26 16:30:28][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:28][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:28][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:28][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:28][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:28][chn3] CURL: Received 26 bytes
[Jun 26 16:30:28][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:28][chn3] CURL: Closing connection 69
[Jun 26 16:30:28][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:28][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:28][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:29][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:29][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:29][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:29][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:29][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:30][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:30][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:30][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951429754
[Jun 26 16:30:30][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951429754
[Jun 26 16:30:30][chn3] Adding reading to queue (value=1.00 ts=1466951429754)
[Jun 26 16:30:30][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:30][chn3] ==> number of tuples: 1
[Jun 26 16:30:30][chn3] compare: 1466951427917 1466951429754
[Jun 26 16:30:30][chn3] JSON request body: [ [ 1466951429754, 1 ] ]
[Jun 26 16:30:30][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:30][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:30][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#70)
[Jun 26 16:30:30][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:30][chn3] CURL: Sent '[ [ 1466951429754, 1 ] ]' bytes
[Jun 26 16:30:30][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:30][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:30][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:30][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:30][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:30][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:30][chn3] CURL: Received 26 bytes
[Jun 26 16:30:30][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:30][chn3] CURL: Closing connection 70
[Jun 26 16:30:30][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:30][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:31][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:31][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:31][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:31][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:31][mtr2] Reading: id=Power/StringItentifier: value=356.72 ts=1466951431074
[Jun 26 16:30:31][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951431074
[Jun 26 16:30:31][chn2] Adding reading to queue (value=1.00 ts=1466951431074)
[Jun 26 16:30:31][chn2] ==> number of tuples: 1
[Jun 26 16:30:31][chn2] compare: 1466951420982 1466951431074
[Jun 26 16:30:31][chn2] JSON request body: [ [ 1466951431074, 1 ] ]
[Jun 26 16:30:31][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:31][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:31][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:31][mtr3] Reading: id=Power/StringItentifier: value=1955.46 ts=1466951431595
[Jun 26 16:30:31][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951431595
[Jun 26 16:30:31][chn3] Adding reading to queue (value=1.00 ts=1466951431595)
[Jun 26 16:30:31][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:31][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:31][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:31][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#71)
[Jun 26 16:30:31][chn3] ==> number of tuples: 1
[Jun 26 16:30:31][chn3] compare: 1466951429754 1466951431595
[Jun 26 16:30:31][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:31][chn2] CURL: Sent '[ [ 1466951431074, 1 ] ]' bytes
[Jun 26 16:30:31][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:31][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:31][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:31][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:32][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:32][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:32][chn2] CURL: Received 26 bytes
[Jun 26 16:30:32][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:32][chn2] CURL: Closing connection 71
[Jun 26 16:30:32][chn3] JSON request body: [ [ 1466951431595, 1 ] ]
[Jun 26 16:30:32][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:32][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:32][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#72)
[Jun 26 16:30:32][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:32][chn3] CURL: Sent '[ [ 1466951431595, 1 ] ]' bytes
[Jun 26 16:30:32][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:32][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:32][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:32][chn3] CURL: Received 26 bytes
[Jun 26 16:30:32][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:32][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:32][chn3] CURL: Closing connection 72
[Jun 26 16:30:32][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:32][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:32][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:32][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:33][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:33][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:33][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:33][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:33][mtr3] Reading: id=Power/StringItentifier: value=1960.78 ts=1466951433431
[Jun 26 16:30:33][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951433431
[Jun 26 16:30:33][chn3] Adding reading to queue (value=1.00 ts=1466951433431)
[Jun 26 16:30:33][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:33][chn3] ==> number of tuples: 1
[Jun 26 16:30:33][chn3] compare: 1466951431595 1466951433431
[Jun 26 16:30:33][chn3] JSON request body: [ [ 1466951433431, 1 ] ]
[Jun 26 16:30:33][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:33][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:33][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#73)
[Jun 26 16:30:33][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:33][chn3] CURL: Sent '[ [ 1466951433431, 1 ] ]' bytes
[Jun 26 16:30:33][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:33][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:33][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:33][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:33][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:33][chn3] CURL: Received 26 bytes
[Jun 26 16:30:33][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:33][chn3] CURL: Closing connection 73
[Jun 26 16:30:33][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:34][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:35][w1t]  read 11.750000 from /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=11750
)
[Jun 26 16:30:35][w1t]  reading w1 device 28-0000045c6924 returned 11.750000
[Jun 26 16:30:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:35][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:35][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:35][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:35][mtr3] Reading: id=Power/StringItentifier: value=1952.28 ts=1466951435275
[Jun 26 16:30:35][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951435275
[Jun 26 16:30:35][chn3] Adding reading to queue (value=1.00 ts=1466951435275)
[Jun 26 16:30:35][chn3] ==> number of tuples: 1
[Jun 26 16:30:35][chn3] compare: 1466951433431 1466951435275
[Jun 26 16:30:35][chn3] JSON request body: [ [ 1466951435275, 1 ] ]
[Jun 26 16:30:35][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:35][chn3] CURL: Hostname in DNS cache was stale, zapped
[Jun 26 16:30:35][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:35][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:35][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#74)
[Jun 26 16:30:35][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:35][chn3] CURL: Sent '[ [ 1466951435275, 1 ] ]' bytes
[Jun 26 16:30:35][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:35][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:35][w1t]  read 13.500000 from /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=13500
)
[Jun 26 16:30:35][w1t]  reading w1 device 28-0000045c5c7e returned 13.500000
[Jun 26 16:30:35][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:35][chn3] CURL: Received 26 bytes
[Jun 26 16:30:35][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:35][chn3] CURL: Closing connection 74
[Jun 26 16:30:35][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:36][w1t]  read 42.937000 from /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=42937
)
[Jun 26 16:30:36][w1t]  reading w1 device 28-0000045d2497 returned 42.937000
[Jun 26 16:30:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:36][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:37][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:37][w1t]  read 21.875000 from /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=21875
)
[Jun 26 16:30:37][w1t]  reading w1 device 28-0000045d7eb0 returned 21.875000
[Jun 26 16:30:37][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:37][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:37][mtr3] Reading: id=Power/StringItentifier: value=1957.59 ts=1466951437114
[Jun 26 16:30:37][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951437114
[Jun 26 16:30:37][chn3] Adding reading to queue (value=1.00 ts=1466951437114)
[Jun 26 16:30:37][chn3] ==> number of tuples: 1
[Jun 26 16:30:37][chn3] compare: 1466951435275 1466951437114
[Jun 26 16:30:37][chn3] JSON request body: [ [ 1466951437114, 1 ] ]
[Jun 26 16:30:37][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:37][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:37][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#75)
[Jun 26 16:30:37][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:37][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:37][chn3] CURL: Sent '[ [ 1466951437114, 1 ] ]' bytes
[Jun 26 16:30:37][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:37][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:37][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:37][chn3] CURL: Received 26 bytes
[Jun 26 16:30:37][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:37][chn3] CURL: Closing connection 75
[Jun 26 16:30:37][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:38][w1t]  read 22.062000 from /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=22062
)
[Jun 26 16:30:38][w1t]  reading w1 device 28-000004a2845a returned 22.062000
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:38][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:39][w1t]  read 12.000000 from /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=12000
)
[Jun 26 16:30:39][w1t]  reading w1 device 28-000004c913d5 returned 12.000000
[Jun 26 16:30:39][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:39][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:39][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951438951
[Jun 26 16:30:39][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951438951
[Jun 26 16:30:39][chn3] Adding reading to queue (value=1.00 ts=1466951438951)
[Jun 26 16:30:39][chn3] ==> number of tuples: 1
[Jun 26 16:30:39][chn3] compare: 1466951437114 1466951438951
[Jun 26 16:30:39][chn3] JSON request body: [ [ 1466951438951, 1 ] ]
[Jun 26 16:30:39][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:39][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:39][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#76)
[Jun 26 16:30:39][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:39][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:39][chn3] CURL: Sent '[ [ 1466951438951, 1 ] ]' bytes
[Jun 26 16:30:39][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:39][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:40][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=12125
)
[Jun 26 16:30:40][w1t]  reading w1 device 28-000004c9583f returned 12.125000
[Jun 26 16:30:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:40][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:40][chn3] CURL: Received 26 bytes
[Jun 26 16:30:40][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:40][chn3] CURL: Closing connection 76
[Jun 26 16:30:40][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:40][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:40][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:40][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c963b9/w1_slave (t=11750
)
[Jun 26 16:30:40][w1t]  reading w1 device 28-000004c963b9 returned 11.750000
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:41][w1t]  read 12.187000 from /sys/bus/w1/devices/28-000004c969de/w1_slave (t=12187
)
[Jun 26 16:30:41][w1t]  reading w1 device 28-000004c969de returned 12.187000
[Jun 26 16:30:41][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:41][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:41][mtr2] Reading: id=Power/StringItentifier: value=357.32 ts=1466951441149
[Jun 26 16:30:41][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951441149
[Jun 26 16:30:41][chn2] Adding reading to queue (value=1.00 ts=1466951441149)
[Jun 26 16:30:41][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:41][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:41][mtr3] Reading: id=Power/StringItentifier: value=1958.65 ts=1466951440789
[Jun 26 16:30:41][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951440789
[Jun 26 16:30:41][chn3] Adding reading to queue (value=1.00 ts=1466951440789)
[Jun 26 16:30:41][chn2] ==> number of tuples: 1
[Jun 26 16:30:41][chn2] compare: 1466951431074 1466951441149
[Jun 26 16:30:41][chn2] JSON request body: [ [ 1466951441149, 1 ] ]
[Jun 26 16:30:41][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:41][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:41][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#77)
[Jun 26 16:30:41][chn3] ==> number of tuples: 1
[Jun 26 16:30:41][chn3] compare: 1466951438951 1466951440789
[Jun 26 16:30:41][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:41][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:41][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:41][chn2] CURL: Sent '[ [ 1466951441149, 1 ] ]' bytes
[Jun 26 16:30:41][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:41][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:41][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:41][chn2] CURL: Received 26 bytes
[Jun 26 16:30:41][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:41][chn2] CURL: Closing connection 77
[Jun 26 16:30:41][chn3] JSON request body: [ [ 1466951440789, 1 ] ]
[Jun 26 16:30:41][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:41][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:41][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#78)
[Jun 26 16:30:41][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:41][chn3] CURL: Sent '[ [ 1466951440789, 1 ] ]' bytes
[Jun 26 16:30:41][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:41][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:41][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:42][chn3] CURL: Received 26 bytes
[Jun 26 16:30:42][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:42][chn3] CURL: Closing connection 78
[Jun 26 16:30:42][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:42][w1t]  read 11.812000 from /sys/bus/w1/devices/28-000004c96a87/w1_slave (t=11812
)
[Jun 26 16:30:42][w1t]  reading w1 device 28-000004c96a87 returned 11.812000
[Jun 26 16:30:42][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:42][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:42][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:42][mtr3] Reading: id=Power/StringItentifier: value=1969.37 ts=1466951442617
[Jun 26 16:30:42][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951442617
[Jun 26 16:30:42][chn3] Adding reading to queue (value=1.00 ts=1466951442617)
[Jun 26 16:30:42][chn3] ==> number of tuples: 1
[Jun 26 16:30:42][chn3] compare: 1466951440789 1466951442617
[Jun 26 16:30:42][chn3] JSON request body: [ [ 1466951442617, 1 ] ]
[Jun 26 16:30:42][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:42][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:42][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#79)
[Jun 26 16:30:42][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:42][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:42][chn3] CURL: Sent '[ [ 1466951442617, 1 ] ]' bytes
[Jun 26 16:30:42][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:42][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:42][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:42][chn3] CURL: Received 26 bytes
[Jun 26 16:30:42][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:42][chn3] CURL: Closing connection 79
[Jun 26 16:30:42][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:43][w1t]  read 23.937000 from /sys/bus/w1/devices/28-000004f2467e/w1_slave (t=23937
)
[Jun 26 16:30:43][w1t]  reading w1 device 28-000004f2467e returned 23.937000
[Jun 26 16:30:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:43][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:44][w1t]  read 23.875000 from /sys/bus/w1/devices/28-000004f1c7c6/w1_slave (t=23875
)
[Jun 26 16:30:44][w1t]  reading w1 device 28-000004f1c7c6 returned 23.875000
[Jun 26 16:30:44][mtr5] Got 12 new readings from meter:
[Jun 26 16:30:44][mtr5] Reading: id=28-0000045c6924/StringItentifier: value=11.75 ts=1466951435039
[Jun 26 16:30:44][mtr5] Reading: id=28-0000045c5c7e/StringItentifier: value=13.50 ts=1466951435873
[Jun 26 16:30:44][mtr5] Reading: id=28-0000045d2497/StringItentifier: value=42.94 ts=1466951436700
[Jun 26 16:30:44][mtr5] Reading: id=28-0000045d7eb0/StringItentifier: value=21.88 ts=1466951437527
[Jun 26 16:30:44][mtr5] Reading: id=28-000004a2845a/StringItentifier: value=22.06 ts=1466951438349
[Jun 26 16:30:44][mtr5] Reading: id=28-000004c913d5/StringItentifier: value=12.00 ts=1466951439170
[Jun 26 16:30:44][mtr5] Reading: id=28-000004c9583f/StringItentifier: value=12.12 ts=1466951440002
[Jun 26 16:30:44][mtr5] Reading: id=28-000004c963b9/StringItentifier: value=11.75 ts=1466951440830
[Jun 26 16:30:44][mtr5] Reading: id=28-000004c969de/StringItentifier: value=12.19 ts=1466951441651
[Jun 26 16:30:44][mtr5] Reading: id=28-000004c96a87/StringItentifier: value=11.81 ts=1466951442475
[Jun 26 16:30:44][mtr5] Reading: id=28-000004f2467e/StringItentifier: value=23.94 ts=1466951443301
[Jun 26 16:30:44][mtr5] Reading: id=28-000004f1c7c6/StringItentifier: value=23.88 ts=1466951444120
[Jun 26 16:30:44][chn5] Adding reading to queue (value=13.50 ts=1466951435873)
[Jun 26 16:30:44][chn6] Adding reading to queue (value=21.88 ts=1466951437527)
[Jun 26 16:30:44][chn7] Adding reading to queue (value=22.06 ts=1466951438349)
[Jun 26 16:30:44][chn8] Adding reading to queue (value=42.94 ts=1466951436700)
[Jun 26 16:30:44][chn9] Adding reading to queue (value=23.88 ts=1466951444120)
[Jun 26 16:30:44][chn10]Adding reading to queue (value=23.94 ts=1466951443301)
[Jun 26 16:30:44][chn11]Adding reading to queue (value=12.19 ts=1466951441651)
[Jun 26 16:30:44][chn12]Adding reading to queue (value=11.81 ts=1466951442475)
[Jun 26 16:30:44][chn13]Adding reading to queue (value=12.12 ts=1466951440002)
[Jun 26 16:30:44][chn14]Adding reading to queue (value=11.75 ts=1466951440830)
[Jun 26 16:30:44][chn15]Adding reading to queue (value=12.00 ts=1466951439170)
[Jun 26 16:30:44][chn16]Adding reading to queue (value=11.75 ts=1466951435039)
[Jun 26 16:30:44][chn5] ==> number of tuples: 1
[Jun 26 16:30:44][chn5] compare: 1466951415866 1466951435873
[Jun 26 16:30:44][chn5] JSON request body: [ [ 1466951435873, 13.5 ] ]
[Jun 26 16:30:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:44][chn5] CURL: Hostname was found in DNS cache
[Jun 26 16:30:44][chn5] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:44][chn5] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#80)
[Jun 26 16:30:44][chn5] Buffer dump (size=0): {}
[Jun 26 16:30:44][chn6] ==> number of tuples: 1
[Jun 26 16:30:44][chn6] compare: 1466951417505 1466951437527
[Jun 26 16:30:44][chn6] Buffer dump (size=0): {}
[Jun 26 16:30:44][chn5] CURL: Sent 27 bytes.. 
[Jun 26 16:30:44][chn5] CURL: Sent '[ [ 1466951435873, 13.5 ] ]' bytes
[Jun 26 16:30:44][chn7] ==> number of tuples: 1
[Jun 26 16:30:44][chn7] compare: 1466951418340 1466951438349
[Jun 26 16:30:44][chn7] Buffer dump (size=0): {}
[Jun 26 16:30:44][chn5] CURL: upload completely sent off: 27 out of 27 bytes
[Jun 26 16:30:44][chn8] ==> number of tuples: 1
[Jun 26 16:30:44][chn8] compare: 1466951416680 1466951436700
[Jun 26 16:30:44][chn8] Buffer dump (size=1): {42.9370,}
[Jun 26 16:30:44][chn9] ==> number of tuples: 1
[Jun 26 16:30:44][chn9] compare: 1466951424104 1466951444120
[Jun 26 16:30:44][chn9] Buffer dump (size=0): {}
[Jun 26 16:30:44][chn10]==> number of tuples: 1
[Jun 26 16:30:44][chn10]compare: 1466951423262 1466951443301
[Jun 26 16:30:44][chn10]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn11]==> number of tuples: 1
[Jun 26 16:30:44][chn11]compare: 1466951421620 1466951441651
[Jun 26 16:30:44][chn11]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn12]==> number of tuples: 1
[Jun 26 16:30:44][chn12]compare: 1466951422441 1466951442475
[Jun 26 16:30:44][chn12]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn13]==> number of tuples: 1
[Jun 26 16:30:44][chn13]compare: 1466951419980 1466951440002
[Jun 26 16:30:44][chn13]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn14]==> number of tuples: 1
[Jun 26 16:30:44][chn14]compare: 1466951420801 1466951440830
[Jun 26 16:30:44][chn14]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn15]==> number of tuples: 1
[Jun 26 16:30:44][chn15]compare: 1466951419160 1466951439170
[Jun 26 16:30:44][chn15]Buffer dump (size=0): {}
[Jun 26 16:30:44][chn16]==> number of tuples: 1
[Jun 26 16:30:44][chn16]compare: 1466951414788 1466951435039
[Jun 26 16:30:44][chn16]Buffer dump (size=0): {}
[Jun 26 16:30:44][mtr5] Next reading in 10 seconds
[Jun 26 16:30:44][chn5] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:44][chn5] CURL: Received 26 bytes
[Jun 26 16:30:44][chn5] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:44][chn5] CURL: Closing connection 80
[Jun 26 16:30:44][chn6] JSON request body: [ [ 1466951437527, 21.875 ] ]
[Jun 26 16:30:44][chn6] CURL: Hostname was found in DNS cache
[Jun 26 16:30:44][chn6] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:44][chn6] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#81)
[Jun 26 16:30:44][chn6] CURL: Sent 29 bytes.. 
[Jun 26 16:30:44][chn6] CURL: Sent '[ [ 1466951437527, 21.875 ] ]' bytes
[Jun 26 16:30:44][chn6] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:44][chn5] CURL Request succeeded with code: 200
[Jun 26 16:30:44][chn6] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:44][chn6] CURL: Received 26 bytes
[Jun 26 16:30:44][chn6] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:44][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:44][chn6] CURL: Closing connection 81
[Jun 26 16:30:44][chn7] JSON request body: [ [ 1466951438349, 22.062000000000001 ] ]
[Jun 26 16:30:44][chn7] CURL: Hostname was found in DNS cache
[Jun 26 16:30:44][chn7] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:44][chn7] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#82)
[Jun 26 16:30:44][chn7] CURL: Sent 41 bytes.. 
[Jun 26 16:30:44][chn7] CURL: Sent '[ [ 1466951438349, 22.062000000000001 ] ]' bytes
[Jun 26 16:30:44][chn7] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:44][chn6] CURL Request succeeded with code: 200
[Jun 26 16:30:44][chn7] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:44][chn7] CURL: Received 26 bytes
[Jun 26 16:30:44][chn7] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:44][chn7] CURL: Closing connection 82
[Jun 26 16:30:44][chn8] JSON request body: [ [ 1466951436700, 42.936999999999998 ] ]
[Jun 26 16:30:44][chn8] CURL: Hostname was found in DNS cache
[Jun 26 16:30:44][chn8] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:44][chn8] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#83)
[Jun 26 16:30:44][chn8] CURL: Sent 41 bytes.. 
[Jun 26 16:30:44][chn8] CURL: Sent '[ [ 1466951436700, 42.936999999999998 ] ]' bytes
[Jun 26 16:30:44][chn8] CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:44][chn7] CURL Request succeeded with code: 200
[Jun 26 16:30:44][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:44][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:44][mtr3] Reading: id=Power/StringItentifier: value=1960.78 ts=1466951444453
[Jun 26 16:30:44][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951444453
[Jun 26 16:30:44][chn3] Adding reading to queue (value=1.00 ts=1466951444453)
[Jun 26 16:30:44][chn3] ==> number of tuples: 1
[Jun 26 16:30:44][chn3] compare: 1466951442617 1466951444453
[Jun 26 16:30:44][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:44][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:44][chn8] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:44][chn8] CURL: Received 26 bytes
[Jun 26 16:30:44][chn8] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:44][chn8] CURL: Closing connection 83
[Jun 26 16:30:44][chn9] JSON request body: [ [ 1466951444120, 23.875 ] ]
[Jun 26 16:30:44][chn9] CURL: Hostname was found in DNS cache
[Jun 26 16:30:44][chn9] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:44][chn9] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#84)
[Jun 26 16:30:44][chn9] CURL: Sent 29 bytes.. 
[Jun 26 16:30:44][chn9] CURL: Sent '[ [ 1466951444120, 23.875 ] ]' bytes
[Jun 26 16:30:44][chn9] CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:44][chn8] CURL Request succeeded with code: 200
[Jun 26 16:30:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:45][chn9] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:45][chn9] CURL: Received 26 bytes
[Jun 26 16:30:45][chn9] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:45][chn9] CURL: Closing connection 84
[Jun 26 16:30:45][chn3] JSON request body: [ [ 1466951444453, 1 ] ]
[Jun 26 16:30:45][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:45][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:45][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#85)
[Jun 26 16:30:45][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:45][chn3] CURL: Sent '[ [ 1466951444453, 1 ] ]' bytes
[Jun 26 16:30:45][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:45][chn9] CURL Request succeeded with code: 200
[Jun 26 16:30:45][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:45][chn3] CURL: Received 26 bytes
[Jun 26 16:30:45][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:45][chn3] CURL: Closing connection 85
[Jun 26 16:30:45][chn10]JSON request body: [ [ 1466951443301, 23.937000000000001 ] ]
[Jun 26 16:30:45][chn10]CURL: Hostname was found in DNS cache
[Jun 26 16:30:45][chn10]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:45][chn10]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#86)
[Jun 26 16:30:45][chn10]CURL: Sent 41 bytes.. 
[Jun 26 16:30:45][chn10]CURL: Sent '[ [ 1466951443301, 23.937000000000001 ] ]' bytes
[Jun 26 16:30:45][chn10]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:45][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:45][chn10]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:45][chn10]CURL: Received 26 bytes
[Jun 26 16:30:45][chn10]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:45][chn10]CURL: Closing connection 86
[Jun 26 16:30:45][chn11]JSON request body: [ [ 1466951441651, 12.186999999999999 ] ]
[Jun 26 16:30:45][chn11]CURL: Hostname was found in DNS cache
[Jun 26 16:30:45][chn11]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:45][chn11]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#87)
[Jun 26 16:30:45][chn11]CURL: Sent 41 bytes.. 
[Jun 26 16:30:45][chn11]CURL: Sent '[ [ 1466951441651, 12.186999999999999 ] ]' bytes
[Jun 26 16:30:45][chn11]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:45][chn10]CURL Request succeeded with code: 200
[Jun 26 16:30:45][chn11]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:45][chn11]CURL: Received 26 bytes
[Jun 26 16:30:45][chn11]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:45][chn11]CURL: Closing connection 87
[Jun 26 16:30:45][chn12]JSON request body: [ [ 1466951442475, 11.811999999999999 ] ]
[Jun 26 16:30:45][chn12]CURL: Hostname was found in DNS cache
[Jun 26 16:30:45][chn12]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:45][chn12]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#88)
[Jun 26 16:30:45][chn12]CURL: Sent 41 bytes.. 
[Jun 26 16:30:45][chn12]CURL: Sent '[ [ 1466951442475, 11.811999999999999 ] ]' bytes
[Jun 26 16:30:45][chn12]CURL: upload completely sent off: 41 out of 41 bytes
[Jun 26 16:30:45][chn11]CURL Request succeeded with code: 200
[Jun 26 16:30:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:45][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:45][chn12]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:45][chn12]CURL: Received 26 bytes
[Jun 26 16:30:45][chn12]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:45][chn12]CURL: Closing connection 88
[Jun 26 16:30:45][chn13]JSON request body: [ [ 1466951440002, 12.125 ] ]
[Jun 26 16:30:45][chn13]CURL: Hostname was found in DNS cache
[Jun 26 16:30:45][chn13]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:45][chn13]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#89)
[Jun 26 16:30:45][chn13]CURL: Sent 29 bytes.. 
[Jun 26 16:30:45][chn13]CURL: Sent '[ [ 1466951440002, 12.125 ] ]' bytes
[Jun 26 16:30:45][chn13]CURL: upload completely sent off: 29 out of 29 bytes
[Jun 26 16:30:45][chn12]CURL Request succeeded with code: 200
[Jun 26 16:30:46][chn13]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:46][chn13]CURL: Received 26 bytes
[Jun 26 16:30:46][chn13]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:46][chn13]CURL: Closing connection 89
[Jun 26 16:30:46][chn14]JSON request body: [ [ 1466951440830, 11.75 ] ]
[Jun 26 16:30:46][chn14]CURL: Hostname was found in DNS cache
[Jun 26 16:30:46][chn14]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:46][chn14]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#90)
[Jun 26 16:30:46][chn14]CURL: Sent 28 bytes.. 
[Jun 26 16:30:46][chn14]CURL: Sent '[ [ 1466951440830, 11.75 ] ]' bytes
[Jun 26 16:30:46][chn14]CURL: upload completely sent off: 28 out of 28 bytes[Jun 26 16:30:46][chn13]CURL Request succeeded with code: 200

[Jun 26 16:30:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:46][chn14]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:46][chn14]CURL: Received 26 bytes
[Jun 26 16:30:46][chn14]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:46][chn14]CURL: Closing connection 90
[Jun 26 16:30:46][chn15]JSON request body: [ [ 1466951439170, 12 ] ]
[Jun 26 16:30:46][chn15]CURL: Hostname was found in DNS cache
[Jun 26 16:30:46][chn15]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:46][chn15]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#91)
[Jun 26 16:30:46][chn15]CURL: Sent 25 bytes.. 
[Jun 26 16:30:46][chn15]CURL: Sent '[ [ 1466951439170, 12 ] ]' bytes
[Jun 26 16:30:46][chn15]CURL: upload completely sent off: 25 out of 25 bytes
[Jun 26 16:30:46][chn14]CURL Request succeeded with code: 200
[Jun 26 16:30:46][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:46][chn15]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:46][chn15]CURL: Received 26 bytes
[Jun 26 16:30:46][chn15]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:46][chn15]CURL: Closing connection 91
[Jun 26 16:30:46][chn16]JSON request body: [ [ 1466951435039, 11.75 ] ]
[Jun 26 16:30:46][chn16]CURL: Hostname was found in DNS cache
[Jun 26 16:30:46][chn16]CURL:   Trying 127.0.0.1...
[Jun 26 16:30:46][chn16]CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#92)
[Jun 26 16:30:46][chn16]CURL: Sent 28 bytes.. 
[Jun 26 16:30:46][chn16]CURL: Sent '[ [ 1466951435039, 11.75 ] ]' bytes
[Jun 26 16:30:46][chn16]CURL: upload completely sent off: 28 out of 28 bytes
[Jun 26 16:30:46][chn15]CURL Request succeeded with code: 200
[Jun 26 16:30:46][chn16]CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:46][chn16]CURL: Received 26 bytes
[Jun 26 16:30:46][chn16]CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:46][chn16]CURL: Closing connection 92
[Jun 26 16:30:46][chn16]CURL Request succeeded with code: 200
[Jun 26 16:30:46][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:46][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:46][mtr3] Reading: id=Power/StringItentifier: value=1956.52 ts=1466951446293
[Jun 26 16:30:46][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951446293
[Jun 26 16:30:46][chn3] Adding reading to queue (value=1.00 ts=1466951446293)
[Jun 26 16:30:46][chn3] ==> number of tuples: 1
[Jun 26 16:30:46][chn3] compare: 1466951444453 1466951446293
[Jun 26 16:30:46][chn3] JSON request body: [ [ 1466951446293, 1 ] ]
[Jun 26 16:30:46][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:46][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:46][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#93)
[Jun 26 16:30:46][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:46][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:46][chn3] CURL: Sent '[ [ 1466951446293, 1 ] ]' bytes
[Jun 26 16:30:46][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:46][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:46][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:46][chn3] CURL: Received 26 bytes
[Jun 26 16:30:46][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:46][chn3] CURL: Closing connection 93
[Jun 26 16:30:46][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:47][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:48][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:48][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:48][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:48][mtr3] Reading: id=Power/StringItentifier: value=1959.72 ts=1466951448130
[Jun 26 16:30:48][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951448130
[Jun 26 16:30:48][chn3] Adding reading to queue (value=1.00 ts=1466951448130)
[Jun 26 16:30:48][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:48][chn3] ==> number of tuples: 1
[Jun 26 16:30:48][chn3] compare: 1466951446293 1466951448130
[Jun 26 16:30:48][chn3] JSON request body: [ [ 1466951448130, 1 ] ]
[Jun 26 16:30:48][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:48][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:48][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#94)
[Jun 26 16:30:48][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:48][chn3] CURL: Sent '[ [ 1466951448130, 1 ] ]' bytes
[Jun 26 16:30:48][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:48][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:48][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:48][chn3] CURL: Received 26 bytes
[Jun 26 16:30:48][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:48][chn3] CURL: Closing connection 94
[Jun 26 16:30:48][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:49][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:50][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:50][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:50][mtr3] Reading: id=Power/StringItentifier: value=1960.78 ts=1466951449966
[Jun 26 16:30:50][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951449966
[Jun 26 16:30:50][chn3] Adding reading to queue (value=1.00 ts=1466951449966)
[Jun 26 16:30:50][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:50][chn3] ==> number of tuples: 1
[Jun 26 16:30:50][chn3] compare: 1466951448130 1466951449966
[Jun 26 16:30:50][chn3] JSON request body: [ [ 1466951449966, 1 ] ]
[Jun 26 16:30:50][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:50][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:50][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#95)
[Jun 26 16:30:50][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:50][chn3] CURL: Sent '[ [ 1466951449966, 1 ] ]' bytes
[Jun 26 16:30:50][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:50][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:50][chn3] CURL: Received 26 bytes
[Jun 26 16:30:50][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:50][chn3] CURL: Closing connection 95
[Jun 26 16:30:50][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:50][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:51][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:51][mtr2] Got 2 new readings from meter:
[Jun 26 16:30:51][mtr2] Reading: id=Power/StringItentifier: value=359.78 ts=1466951451155
[Jun 26 16:30:51][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951451155
[Jun 26 16:30:51][chn2] Adding reading to queue (value=1.00 ts=1466951451155)
[Jun 26 16:30:51][chn2] ==> number of tuples: 1
[Jun 26 16:30:51][chn2] compare: 1466951441149 1466951451155
[Jun 26 16:30:51][chn2] JSON request body: [ [ 1466951451155, 1 ] ]
[Jun 26 16:30:51][chn2] CURL: Hostname was found in DNS cache
[Jun 26 16:30:51][chn2] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:51][chn2] Buffer dump (size=0): {}
[Jun 26 16:30:51][chn2] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#96)
[Jun 26 16:30:51][chn2] CURL: Sent 24 bytes.. 
[Jun 26 16:30:51][chn2] CURL: Sent '[ [ 1466951451155, 1 ] ]' bytes
[Jun 26 16:30:51][chn2] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:51][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:51][chn2] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:51][chn2] CURL: Received 26 bytes
[Jun 26 16:30:51][chn2] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:51][chn2] CURL: Closing connection 96
[Jun 26 16:30:51][chn2] CURL Request succeeded with code: 200
[Jun 26 16:30:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:52][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:52][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:52][mtr3] Reading: id=Power/StringItentifier: value=1956.52 ts=1466951451806
[Jun 26 16:30:52][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951451806
[Jun 26 16:30:52][chn3] Adding reading to queue (value=1.00 ts=1466951451806)
[Jun 26 16:30:52][chn3] ==> number of tuples: 1
[Jun 26 16:30:52][chn3] compare: 1466951449966 1466951451806
[Jun 26 16:30:52][chn3] JSON request body: [ [ 1466951451806, 1 ] ]
[Jun 26 16:30:52][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:52][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:52][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#97)
[Jun 26 16:30:52][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:52][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:52][chn3] CURL: Sent '[ [ 1466951451806, 1 ] ]' bytes
[Jun 26 16:30:52][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:52][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:52][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:52][chn3] CURL: Received 26 bytes
[Jun 26 16:30:52][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:52][chn3] CURL: Closing connection 97
[Jun 26 16:30:52][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:53][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:53][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:53][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:53][mtr3] Reading: id=Power/StringItentifier: value=1956.52 ts=1466951453646
[Jun 26 16:30:53][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951453646
[Jun 26 16:30:53][chn3] Adding reading to queue (value=1.00 ts=1466951453646)
[Jun 26 16:30:53][chn3] Buffer dump (size=1): {1.0000,}
[Jun 26 16:30:53][chn3] ==> number of tuples: 1
[Jun 26 16:30:53][chn3] compare: 1466951451806 1466951453646
[Jun 26 16:30:53][chn3] JSON request body: [ [ 1466951453646, 1 ] ]
[Jun 26 16:30:53][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:53][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:53][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#98)
[Jun 26 16:30:53][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:53][chn3] CURL: Sent '[ [ 1466951453646, 1 ] ]' bytes
[Jun 26 16:30:53][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:53][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:53][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:53][chn3] CURL: Received 26 bytes
[Jun 26 16:30:53][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:53][chn3] CURL: Closing connection 98
[Jun 26 16:30:53][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:54][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:55][w1t]  read 11.750000 from /sys/bus/w1/devices/28-0000045c6924/w1_slave (t=11750
)
[Jun 26 16:30:55][w1t]  reading w1 device 28-0000045c6924 returned 11.750000
[Jun 26 16:30:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:55][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:55][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:55][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:55][mtr3] Reading: id=Power/StringItentifier: value=1956.52 ts=1466951455486
[Jun 26 16:30:55][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951455486
[Jun 26 16:30:55][chn3] Adding reading to queue (value=1.00 ts=1466951455486)
[Jun 26 16:30:55][chn3] ==> number of tuples: 1
[Jun 26 16:30:55][chn3] compare: 1466951453646 1466951455486
[Jun 26 16:30:55][chn3] JSON request body: [ [ 1466951455486, 1 ] ]
[Jun 26 16:30:55][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:55][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:55][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#99)
[Jun 26 16:30:55][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:55][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:55][chn3] CURL: Sent '[ [ 1466951455486, 1 ] ]' bytes
[Jun 26 16:30:55][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:55][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:55][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:55][w1t]  read 13.500000 from /sys/bus/w1/devices/28-0000045c5c7e/w1_slave (t=13500
)
[Jun 26 16:30:55][w1t]  reading w1 device 28-0000045c5c7e returned 13.500000
[Jun 26 16:30:55][chn3] CURL: Received 26 bytes
[Jun 26 16:30:55][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:55][chn3] CURL: Closing connection 99
[Jun 26 16:30:55][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:56][w1t]  read 42.875000 from /sys/bus/w1/devices/28-0000045d2497/w1_slave (t=42875
)
[Jun 26 16:30:56][w1t]  reading w1 device 28-0000045d2497 returned 42.875000
[Jun 26 16:30:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:56][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:57][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:57][w1t]  read 21.875000 from /sys/bus/w1/devices/28-0000045d7eb0/w1_slave (t=21875
)
[Jun 26 16:30:57][w1t]  reading w1 device 28-0000045d7eb0 returned 21.875000
[Jun 26 16:30:57][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:57][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:57][mtr3] Reading: id=Power/StringItentifier: value=1950.16 ts=1466951457332
[Jun 26 16:30:57][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951457332
[Jun 26 16:30:57][chn3] Adding reading to queue (value=1.00 ts=1466951457332)
[Jun 26 16:30:57][chn3] ==> number of tuples: 1
[Jun 26 16:30:57][chn3] compare: 1466951455486 1466951457332
[Jun 26 16:30:57][chn3] JSON request body: [ [ 1466951457332, 1 ] ]
[Jun 26 16:30:57][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:57][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:57][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#100)
[Jun 26 16:30:57][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:57][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:57][chn3] CURL: Sent '[ [ 1466951457332, 1 ] ]' bytes
[Jun 26 16:30:57][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:57][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:57][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:30:57][chn3] CURL: Received 26 bytes
[Jun 26 16:30:57][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:30:57][chn3] CURL: Closing connection 100
[Jun 26 16:30:57][chn3] CURL Request succeeded with code: 200
[Jun 26 16:30:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:58][w1t]  read 22.062000 from /sys/bus/w1/devices/28-000004a2845a/w1_slave (t=22062
)
[Jun 26 16:30:58][w1t]  reading w1 device 28-000004a2845a returned 22.062000
[Jun 26 16:30:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:58][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:59][w1t]  read 12.000000 from /sys/bus/w1/devices/28-000004c913d5/w1_slave (t=12000
)
[Jun 26 16:30:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:59][w1t]  reading w1 device 28-000004c913d5 returned 12.000000
[Jun 26 16:30:59][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:30:59][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:30:59][mtr3] Got 2 new readings from meter:
[Jun 26 16:30:59][mtr3] Reading: id=Power/StringItentifier: value=1963.99 ts=1466951459165
[Jun 26 16:30:59][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951459165
[Jun 26 16:30:59][chn3] Adding reading to queue (value=1.00 ts=1466951459165)
[Jun 26 16:30:59][chn3] ==> number of tuples: 1
[Jun 26 16:30:59][chn3] compare: 1466951457332 1466951459165
[Jun 26 16:30:59][chn3] JSON request body: [ [ 1466951459165, 1 ] ]
[Jun 26 16:30:59][chn3] CURL: Hostname was found in DNS cache
[Jun 26 16:30:59][chn3] CURL:   Trying 127.0.0.1...
[Jun 26 16:30:59][chn3] CURL: Connected to 127.0.0.1 (127.0.0.1) port 80 (#101)
[Jun 26 16:30:59][chn3] Buffer dump (size=0): {}
[Jun 26 16:30:59][chn3] CURL: Sent 24 bytes.. 
[Jun 26 16:30:59][chn3] CURL: Sent '[ [ 1466951459165, 1 ] ]' bytes
[Jun 26 16:30:59][chn3] CURL: upload completely sent off: 24 out of 24 bytes
[Jun 26 16:30:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:59][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:30:59][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c9583f/w1_slave (t=12125
)
[Jun 26 16:30:59][w1t]  reading w1 device 28-000004c9583f returned 12.125000
[Jun 26 16:31:00][chn3] CURL: HTTP 1.0, assume close after body
[Jun 26 16:31:00][chn3] CURL: Received 26 bytes
[Jun 26 16:31:00][chn3] CURL: Received '{"version":"0.3","rows":1}' bytes
[Jun 26 16:31:00][chn3] CURL: Closing connection 101
[Jun 26 16:31:00][chn3] CURL Request succeeded with code: 200
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 0
[Jun 26 16:31:00][w1t]  read 11.750000 from /sys/bus/w1/devices/28-000004c963b9/w1_slave (t=11750
)
[Jun 26 16:31:00][w1t]  reading w1 device 28-000004c963b9 returned 11.750000
[Jun 26 16:31:00][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:31:01][S0]   MeterS0:HWIF_GPIO:first poll returned 1
[Jun 26 16:31:01][w1t]  read 12.125000 from /sys/bus/w1/devices/28-000004c969de/w1_slave (t=12125
)
[Jun 26 16:31:01][w1t]  reading w1 device 28-000004c969de returned 12.125000
[Jun 26 16:31:01]       MapContainer::quit terminating on signal 15.
[Jun 26 16:31:01]       Closing connections to terminate
[Jun 26 16:31:01][main] MeterMap::cancel entered...
[Jun 26 16:31:01][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:31:01][mtr2] Got 2 new readings from meter:
[Jun 26 16:31:01][mtr2] Reading: id=Power/StringItentifier: value=363.16 ts=1466951461068
[Jun 26 16:31:01][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951461068
[Jun 26 16:31:01][chn2] Adding reading to queue (value=1.00 ts=1466951461068)
[Jun 26 16:31:01][main] MeterMap::cancel wait for readingthread
[Jun 26 16:31:01][s0]   Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Jun 26 16:31:01][mtr3] Got 2 new readings from meter:
[Jun 26 16:31:01][mtr3] Reading: id=Power/StringItentifier: value=1962.92 ts=1466951460999
[Jun 26 16:31:01][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1466951460999
[Jun 26 16:31:01][chn2] ==> number of tuples: 1
[Jun 26 16:31:01][chn2] compare: 1466951451155 1466951461068


More information about the volkszaehler-users mailing list