Skip to content

Instantly share code, notes, and snippets.

@gitka
Last active April 1, 2016 21:06
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save gitka/f0e8297fed3a0a716e9e to your computer and use it in GitHub Desktop.
Save gitka/f0e8297fed3a0a716e9e to your computer and use it in GitHub Desktop.
vzlogger.log S0
[Apr 01 21:37:46] Opened logfile /home/pi/vzlogger.log
[Apr 01 21:37:46][push] No pushDataServer defined.
[Apr 01 21:37:46][] ===> Start meters
[Apr 01 21:37:46][mtr0] Meter connection established
[Apr 01 21:37:46][mtr0] Meter thread started
[Apr 01 21:37:46][mtr0] Meter is opened. Starting channels.
[Apr 01 21:37:46][chn0] Logging thread not started
[Apr 01 21:37:46][chn1] Logging thread not started
[Apr 01 21:37:46][s0] counter_thread created
[Apr 01 21:37:46][mtr1] Meter connection established
[Apr 01 21:37:46][mtr1] Meter thread started
[Apr 01 21:37:46][mtr1] Meter is opened. Starting channels.
[Apr 01 21:37:46][chn2] Logging thread not started
[Apr 01 21:37:46][s0] counter_thread created
[Apr 01 21:37:46][mtr2] Meter connection established
[Apr 01 21:37:46][mtr0] Number of readers: 400
[Apr 01 21:37:46][mtr0] Config.daemon: 0
[Apr 01 21:37:46][mtr0] Config.local: 1
[Apr 01 21:37:46][d0] sending pullsequenz send (len:5 is:5).
[Apr 01 21:37:46][mtr1] Number of readers: 4
[Apr 01 21:37:46][mtr1] Config.daemon: 0
[Apr 01 21:37:46][mtr1] Config.local: 1
[Apr 01 21:37:46][s0] Counter thread started with blocking hwif
[Apr 01 21:37:46][s0] Counter thread started with blocking hwif
[Apr 01 21:37:46][mtr2] Meter thread started
[Apr 01 21:37:46][mtr2] Meter is opened. Starting channels.
[Apr 01 21:37:46][chn3] Logging thread not started
[Apr 01 21:37:46][s0] counter_thread created
[Apr 01 21:37:46][mtr3] Meter connection established
[Apr 01 21:37:46][mtr3] Meter thread started
[Apr 01 21:37:46][mtr3] Meter is opened. Starting channels.
[Apr 01 21:37:46][chn4] Logging thread not started
[Apr 01 21:37:46][s0] counter_thread created
[Apr 01 21:37:46][mtr2] Number of readers: 4
[Apr 01 21:37:46][mtr2] Config.daemon: 0
[Apr 01 21:37:46][mtr2] Config.local: 1
[Apr 01 21:37:46][s0] Counter thread started with blocking hwif
[Apr 01 21:37:46][mtr3] Number of readers: 4
[Apr 01 21:37:46][mtr3] Config.daemon: 0
[Apr 01 21:37:46][mtr3] Config.local: 1
[Apr 01 21:37:46][s0] Counter thread started with blocking hwif
[Apr 01 21:37:46][mtr4] Meter connection established
[Apr 01 21:37:46][mtr4] Meter thread started
[Apr 01 21:37:46][mtr4] Meter is opened. Starting channels.
[Apr 01 21:37:46][chn5] Logging thread not started
[Apr 01 21:37:46][http] Starting local interface HTTPd on port 8080
[Apr 01 21:37:46][] Startup done.
[Apr 01 21:37:46][mtr4] Number of readers: 4
[Apr 01 21:37:46][mtr4] Config.daemon: 0
[Apr 01 21:37:46][mtr4] Config.local: 1
[Apr 01 21:37:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:47][d0] Pull answer (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:37:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:49][http] Local request received: method=GET url=/e18 mode=(null)
[Apr 01 21:37:49][e18] ==> number of tuples: 0
[Apr 01 21:37:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:49][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:37:49][e23] ==> number of tuples: 0
[Apr 01 21:37:49][d0] DEBUG OBIS_CODE byte  hex= 2
[Apr 01 21:37:49][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:37:49][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:49][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:37:49][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:49][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:49][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:49][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:49][http] Local request received: method=GET url=/e2302 mode=(null)
[Apr 01 21:37:49][e2302]==> number of tuples: 0
[Apr 01 21:37:49][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:37:49][180] ==> number of tuples: 0
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:37:50][d0] Parsed reading (OBIS code=F.F, value=00000000, unit=)
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:50][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:37:50][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:37:50][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:50][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:50][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:50][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 7 hex= 37
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:50][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:37:50][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:37:50][d0] Parsed reading (OBIS code=0.0.0, value= 26789, unit=)
[Apr 01 21:37:50][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:50][s0] Reading S0 - returning 1 readings (n=1 n_neg = 0)
[Apr 01 21:37:50][mtr2] Got 1 new readings from meter:
[Apr 01 21:37:50][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539470424
[Apr 01 21:37:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:50][s0] Reading S0 - returning 1 readings (n=1 n_neg = 0)
[Apr 01 21:37:50][mtr3] Got 1 new readings from meter:
[Apr 01 21:37:50][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539470423
[Apr 01 21:37:50][chn4] Buffer dump (size=0): {}
[Apr 01 21:37:50][s0] Reading S0 - returning 1 readings (n=1 n_neg = 0)
[Apr 01 21:37:50][mtr4] Got 1 new readings from meter:
[Apr 01 21:37:50][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539470423
[Apr 01 21:37:50][chn5] Adding reading to queue (value=1.00 ts=1459539470423)
[Apr 01 21:37:50][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:37:51][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:51][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:51][http] Local request received: method=GET url=/280 mode=(null)
[Apr 01 21:37:51][280] ==> number of tuples: 0
[Apr 01 21:37:51][d0] Parsed reading (OBIS code=1.8.1, value=018639.8, unit=kWh)
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:37:51][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:51][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:52][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:52][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:52][d0] Parsed reading (OBIS code=1.8.2, value=000000.0, unit=kWh)
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:37:52][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:52][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:37:52][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:52][d0] Parsed reading (OBIS code=2.8.1, value=023289.6, unit=kWh)
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:52][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:53][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:53][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:53][d0] Parsed reading (OBIS code=2.8.2, value=000000.0, unit=kWh)
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:53][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:37:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:37:54][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:54][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:54][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:54][d0] Parsed reading (OBIS code=1.8.0, value=018639.8, unit=kWh)
[Apr 01 21:37:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:37:54][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:37:55][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:37:55][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:37:55][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:37:55][d0] Parsed reading (OBIS code=2.8.0, value=023289.6, unit=kWh)
[Apr 01 21:37:55][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:55][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:37:55][d0] Read package with 8 tuples (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:37:55][mtr0] Got 8 new readings from meter:
[Apr 01 21:37:55][mtr0] Reading: id=255-255:97.97.255*255/ObisItentifier:255-255:97.97.255*255 value=0.00 ts=1459539470108
[Apr 01 21:37:55][mtr0] Reading: id=255-255:0.0.0*255/ObisItentifier:255-255:0.0.0*255 value=26789.00 ts=1459539470677
[Apr 01 21:37:55][mtr0] Reading: id=255-255:1.8.1*255/ObisItentifier:255-255:1.8.1*255 value=18639.80 ts=1459539471585
[Apr 01 21:37:55][mtr0] Reading: id=255-255:1.8.2*255/ObisItentifier:255-255:1.8.2*255 value=0.00 ts=1459539472462
[Apr 01 21:37:55][mtr0] Reading: id=255-255:2.8.1*255/ObisItentifier:255-255:2.8.1*255 value=23289.60 ts=1459539472994
[Apr 01 21:37:55][mtr0] Reading: id=255-255:2.8.2*255/ObisItentifier:255-255:2.8.2*255 value=0.00 ts=1459539473926
[Apr 01 21:37:55][mtr0] Reading: id=255-255:1.8.0*255/ObisItentifier:255-255:1.8.0*255 value=18639.80 ts=1459539474459
[Apr 01 21:37:55][mtr0] Reading: id=255-255:2.8.0*255/ObisItentifier:255-255:2.8.0*255 value=23289.60 ts=1459539475379
[Apr 01 21:37:55][chn0] Adding reading to queue (value=18639.80 ts=1459539474459)
[Apr 01 21:37:55][chn1] Adding reading to queue (value=23289.60 ts=1459539475379)
[Apr 01 21:37:55][chn0] Buffer dump (size=1): {18639.8000,}
[Apr 01 21:37:55][chn1] Buffer dump (size=1): {23289.6000,}
[Apr 01 21:37:55][mtr0] Next reading in 60 seconds
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:37:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:37:55][mtr2] Got 2 new readings from meter:
[Apr 01 21:37:55][mtr2] Reading: id=Power/StringItentifier: value=868.56 ts=1459539475605
[Apr 01 21:37:55][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539475605
[Apr 01 21:37:55][chn3] Adding reading to queue (value=868.56 ts=1459539475605)
[Apr 01 21:37:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:37:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:55][mtr3] Got 2 new readings from meter:
[Apr 01 21:37:55][mtr3] Reading: id=Power/StringItentifier: value=868.39 ts=1459539475605
[Apr 01 21:37:55][mtr3] [Apr 01 21:37:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:37:55][mtr4] Got 2 new readings from meter:
[Apr 01 21:37:55][mtr4] Reading: id=Power/StringItentifier: value=868.39 ts=1459539475605
[Apr 01 21:37:55][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539475605
[Apr 01 21:37:55][chn5] Adding reading to queue (value=1.00 ts=1459539475605)
Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539475605
[Apr 01 21:37:55][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:37:55][chn4] Adding reading to queue (value=868.39 ts=1459539475605)
[Apr 01 21:37:55][chn4] Buffer dump (size=1): {868.3906,}
[Apr 01 21:37:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:37:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:00][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:38:00][180] ==> number of tuples: 1
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:00][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:01][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:01][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:01][mtr2] Reading: id=Power/StringItentifier: value=854.70 ts=1459539480870
[Apr 01 21:38:01][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539480870
[Apr 01 21:38:01][chn3] Adding reading to queue (value=854.70 ts=1459539480870)
[Apr 01 21:38:01][AVG] [0] 868.558194 @ 1459539475605
[Apr 01 21:38:01][AVG] [1] 854.700876 @ 1459539480870
[Apr 01 21:38:01][AVG] [2] RESULT 868.558194 @ 1459539480870
[Apr 01 21:38:01][chn3] Buffer dump (size=1): {868.5582,}
[Apr 01 21:38:01][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:01][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:01][mtr3] Reading: id=Power/StringItentifier: value=854.86 ts=1459539480869
[Apr 01 21:38:01][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539480869
[Apr 01 21:38:01][chn4] Adding reading to queue (value=854.86 ts=1459539480869)
[Apr 01 21:38:01][chn4] Buffer dump (size=1): {854.8632,}
[Apr 01 21:38:01][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:01][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:01][mtr4] Reading: id=Power/StringItentifier: value=854.86 ts=1459539480869
[Apr 01 21:38:01][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539480869
[Apr 01 21:38:01][chn5] Adding reading to queue (value=1.00 ts=1459539480869)
[Apr 01 21:38:01][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:06][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:06][mtr2] Reading: id=Power/StringItentifier: value=853.57 ts=1459539486142
[Apr 01 21:38:06][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539486142
[Apr 01 21:38:06][chn3] Adding reading to queue (value=853.57 ts=1459539486142)
[Apr 01 21:38:06][AVG] [0] 853.565997 @ 1459539486142
[Apr 01 21:38:06][AVG] [1] RESULT 854.700876 @ 1459539486142
[Apr 01 21:38:06][chn3] Buffer dump (size=1): {854.7009,}
[Apr 01 21:38:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:06][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:06][mtr3] Reading: id=Power/StringItentifier: value=853.40 ts=1459539486142
[Apr 01 21:38:06][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539486142
[Apr 01 21:38:06][chn4] Adding reading to queue (value=853.40 ts=1459539486142)
[Apr 01 21:38:06][chn4] Buffer dump (size=1): {853.4041,}
[Apr 01 21:38:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:06][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:06][mtr4] Reading: id=Power/StringItentifier: value=853.24 ts=1459539486143
[Apr 01 21:38:06][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539486143
[Apr 01 21:38:06][chn5] Adding reading to queue (value=1.00 ts=1459539486143)
[Apr 01 21:38:06][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:11][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:11][mtr2] Reading: id=Power/StringItentifier: value=854.38 ts=1459539491409
[Apr 01 21:38:11][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539491409
[Apr 01 21:38:11][chn3] Adding reading to queue (value=854.38 ts=1459539491409)
[Apr 01 21:38:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:11][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:11][mtr3] Reading: id=Power/StringItentifier: value=854.38 ts=1459539491409
[Apr 01 21:38:11][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539491409
[Apr 01 21:38:11][chn4] Adding reading to queue (value=854.38 ts=1459539491409)
[Apr 01 21:38:11][chn4] Buffer dump (size=1): {854.3763,}
[Apr 01 21:38:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:11][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:11][mtr4] Reading: id=Power/StringItentifier: value=854.70 ts=1459539491408
[Apr 01 21:38:11][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539491408
[Apr 01 21:38:11][chn5] Adding reading to queue (value=1.00 ts=1459539491408)
[Apr 01 21:38:11][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:16][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:16][mtr2] Reading: id=Power/StringItentifier: value=853.40 ts=1459539496682
[Apr 01 21:38:16][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539496682
[Apr 01 21:38:16][chn3] Adding reading to queue (value=853.40 ts=1459539496682)
[Apr 01 21:38:16][AVG] [0] 854.376312 @ 1459539491409
[Apr 01 21:38:16][AVG] [1] 853.404134 @ 1459539496682
[Apr 01 21:38:16][AVG] [2] RESULT 853.971385 @ 1459539496682
[Apr 01 21:38:16][chn3] Buffer dump (size=1): {853.9714,}
[Apr 01 21:38:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:16][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:16][mtr3] Reading: id=Power/StringItentifier: value=853.40 ts=1459539496682
[Apr 01 21:38:16][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539496682
[Apr 01 21:38:16][chn4] Adding reading to queue (value=853.40 ts=1459539496682)
[Apr 01 21:38:16][chn4] Buffer dump (size=1): {853.4041,}
[Apr 01 21:38:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:16][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:16][mtr4] Reading: id=Power/StringItentifier: value=853.24 ts=1459539496682
[Apr 01 21:38:16][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539496682
[Apr 01 21:38:16][chn5] Adding reading to queue (value=1.00 ts=1459539496682)
[Apr 01 21:38:16][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:21][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:22][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:22][mtr2] Reading: id=Power/StringItentifier: value=853.24 ts=1459539501956
[Apr 01 21:38:22][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539501956
[Apr 01 21:38:22][chn3] Adding reading to queue (value=853.24 ts=1459539501956)
[Apr 01 21:38:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:22][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:22][mtr3] Reading: id=Power/StringItentifier: value=853.24 ts=1459539501956
[Apr 01 21:38:22][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539501956
[Apr 01 21:38:22][chn4] Adding reading to queue (value=853.24 ts=1459539501956)
[Apr 01 21:38:22][chn4] Buffer dump (size=1): {853.2423,}
[Apr 01 21:38:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:22][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:22][mtr4] Reading: id=Power/StringItentifier: value=853.40 ts=1459539501955
[Apr 01 21:38:22][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539501955
[Apr 01 21:38:22][chn5] Adding reading to queue (value=1.00 ts=1459539501955)
[Apr 01 21:38:22][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:27][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:27][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:27][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:27][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:27][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:27][mtr2] Reading: id=Power/StringItentifier: value=850.18 ts=1459539507249
[Apr 01 21:38:27][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539507249
[Apr 01 21:38:27][chn3] Adding reading to queue (value=850.18 ts=1459539507249)
[Apr 01 21:38:27][AVG] [0] 853.242332 @ 1459539501956
[Apr 01 21:38:27][AVG] [1] 850.179485 @ 1459539507249
[Apr 01 21:38:27][AVG] [2] RESULT 853.323088 @ 1459539507249
[Apr 01 21:38:27][chn3] Buffer dump (size=1): {853.3231,}
[Apr 01 21:38:27][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:27][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:27][mtr3] Reading: id=Power/StringItentifier: value=850.18 ts=1459539507249
[Apr 01 21:38:27][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539507249
[Apr 01 21:38:27][chn4] Adding reading to queue (value=850.18 ts=1459539507249)
[Apr 01 21:38:27][chn4] Buffer dump (size=1): {850.1795,}
[Apr 01 21:38:27][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:27][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:27][mtr4] Reading: id=Power/StringItentifier: value=849.86 ts=1459539507250
[Apr 01 21:38:27][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539507250
[Apr 01 21:38:27][chn5] Adding reading to queue (value=1.00 ts=1459539507250)
[Apr 01 21:38:27][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:32][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:32][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:32][mtr2] Reading: id=Power/StringItentifier: value=854.38 ts=1459539512516
[Apr 01 21:38:32][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539512516
[Apr 01 21:38:32][chn3] Adding reading to queue (value=854.38 ts=1459539512516)
[Apr 01 21:38:32][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:32][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:32][mtr3] Reading: id=Power/StringItentifier: value=854.38 ts=1459539512516
[Apr 01 21:38:32][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539512516
[Apr 01 21:38:32][chn4] Adding reading to queue (value=854.38 ts=1459539512516)
[Apr 01 21:38:32][chn4] Buffer dump (size=1): {854.3763,}
[Apr 01 21:38:32][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:32][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:32][mtr4] Reading: id=Power/StringItentifier: value=854.54 ts=1459539512516
[Apr 01 21:38:32][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539512516
[Apr 01 21:38:32][chn5] Adding reading to queue (value=1.00 ts=1459539512516)
[Apr 01 21:38:32][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:37][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:38][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:38][mtr2] Reading: id=Power/StringItentifier: value=854.54 ts=1459539517782
[Apr 01 21:38:38][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539517782
[Apr 01 21:38:38][chn3] Adding reading to queue (value=854.54 ts=1459539517782)
[Apr 01 21:38:38][AVG] [0] 854.376273 @ 1459539512516
[Apr 01 21:38:38][AVG] [1] 854.538583 @ 1459539517782
[Apr 01 21:38:38][AVG] [2] RESULT 852.277680 @ 1459539517782
[Apr 01 21:38:38][chn3] Buffer dump (size=1): {852.2777,}
[Apr 01 21:38:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:38][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:38][mtr3] Reading: id=Power/StringItentifier: value=854.54 ts=1459539517782
[Apr 01 21:38:38][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539517782
[Apr 01 21:38:38][chn4] Adding reading to queue (value=854.54 ts=1459539517782)
[Apr 01 21:38:38][chn4] Buffer dump (size=1): {854.5385,}
[Apr 01 21:38:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:38][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:38][mtr4] Reading: id=Power/StringItentifier: value=854.38 ts=1459539517783
[Apr 01 21:38:38][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539517783
[Apr 01 21:38:38][chn5] Adding reading to queue (value=1.00 ts=1459539517783)
[Apr 01 21:38:38][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:43][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:43][mtr2] Reading: id=Power/StringItentifier: value=851.95 ts=1459539523064
[Apr 01 21:38:43][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539523064
[Apr 01 21:38:43][chn3] Adding reading to queue (value=851.95 ts=1459539523064)
[Apr 01 21:38:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:43][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:43][mtr3] Reading: id=Power/StringItentifier: value=852.11 ts=1459539523063
[Apr 01 21:38:43][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539523063
[Apr 01 21:38:43][chn4] Adding reading to queue (value=852.11 ts=1459539523063)
[Apr 01 21:38:43][chn4] Buffer dump (size=1): {852.1113,}
[Apr 01 21:38:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:43][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:43][mtr4] Reading: id=Power/StringItentifier: value=852.27 ts=1459539523063
[Apr 01 21:38:43][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539523063
[Apr 01 21:38:43][chn5] Adding reading to queue (value=1.00 ts=1459539523063)
[Apr 01 21:38:43][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:48][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:48][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:48][mtr2] Reading: id=Power/StringItentifier: value=853.57 ts=1459539528336
[Apr 01 21:38:48][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539528336
[Apr 01 21:38:48][chn3] Adding reading to queue (value=853.57 ts=1459539528336)
[Apr 01 21:38:48][AVG] [0] 851.950008 @ 1459539523064
[Apr 01 21:38:48][AVG] [1] 853.565997 @ 1459539528336
[Apr 01 21:38:48][AVG] [2] RESULT 853.245522 @ 1459539528336
[Apr 01 21:38:48][chn3] Buffer dump (size=1): {853.2455,}
[Apr 01 21:38:48][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:48][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:48][mtr3] Reading: id=Power/StringItentifier: value=853.40 ts=1459539528336
[Apr 01 21:38:48][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539528336
[Apr 01 21:38:48][chn4] Adding reading to queue (value=853.40 ts=1459539528336)
[Apr 01 21:38:48][chn4] Buffer dump (size=1): {853.4041,}
[Apr 01 21:38:48][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:48][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:48][mtr4] Reading: id=Power/StringItentifier: value=853.24 ts=1459539528337
[Apr 01 21:38:48][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539528337
[Apr 01 21:38:48][chn5] Adding reading to queue (value=1.00 ts=1459539528337)
[Apr 01 21:38:48][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:49][http] Local request received: method=GET url=/e18 mode=(null)
[Apr 01 21:38:49][e18] ==> number of tuples: 0
[Apr 01 21:38:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:49][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:38:49][e23] ==> number of tuples: 6
[Apr 01 21:38:49][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:38:49][180] ==> number of tuples: 1
[Apr 01 21:38:49][http] Local request received: method=GET url=/e2302 mode=(null)
[Apr 01 21:38:49][e2302]==> number of tuples: 12
[Apr 01 21:38:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:52][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:38:52][e23] ==> number of tuples: 6
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:53][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:53][mtr2] Reading: id=Power/StringItentifier: value=854.21 ts=1459539533604
[Apr 01 21:38:53][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539533604
[Apr 01 21:38:53][chn3] Adding reading to queue (value=854.21 ts=1459539533604)
[Apr 01 21:38:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:53][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:53][mtr3] Reading: id=Power/StringItentifier: value=854.38 ts=1459539533603
[Apr 01 21:38:53][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539533603
[Apr 01 21:38:53][chn4] Adding reading to queue (value=854.38 ts=1459539533603)
[Apr 01 21:38:53][chn4] Buffer dump (size=1): {854.3763,}
[Apr 01 21:38:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:53][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:53][mtr4] Reading: id=Power/StringItentifier: value=854.54 ts=1459539533603
[Apr 01 21:38:53][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539533603
[Apr 01 21:38:53][chn5] Adding reading to queue (value=1.00 ts=1459539533603)
[Apr 01 21:38:53][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:55][d0] sending pullsequenz send (len:5 is:5).
[Apr 01 21:38:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:56][d0] Pull answer (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:38:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte  hex= 2
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:58][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:38:58][d0] Parsed reading (OBIS code=F.F, value=00000000, unit=)
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:38:58][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:58][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:38:59][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:38:59][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:38:59][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 7 hex= 37
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:38:59][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:38:59][d0] Parsed reading (OBIS code=0.0.0, value= 26789, unit=)
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:38:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:59][mtr2] Got 2 new readings from meter:
[Apr 01 21:38:59][mtr2] Reading: id=Power/StringItentifier: value=852.43 ts=1459539538883
[Apr 01 21:38:59][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539538883
[Apr 01 21:38:59][chn3] Adding reading to queue (value=852.43 ts=1459539538883)
[Apr 01 21:38:59][AVG] [0] 854.214141 @ 1459539533604
[Apr 01 21:38:59][AVG] [1] 852.434166 @ 1459539538883
[Apr 01 21:38:59][AVG] [2] RESULT 853.890407 @ 1459539538883
[Apr 01 21:38:59][chn3] Buffer dump (size=1): {853.8904,}
[Apr 01 21:38:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:59][mtr3] Got 2 new readings from meter:
[Apr 01 21:38:59][mtr3] Reading: id=Power/StringItentifier: value=852.27 ts=1459539538883
[Apr 01 21:38:59][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539538883
[Apr 01 21:38:59][chn4] Adding reading to queue (value=852.27 ts=1459539538883)
[Apr 01 21:38:59][chn4] Buffer dump (size=1): {852.2727,}
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:38:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:38:59][mtr4] Got 2 new readings from meter:
[Apr 01 21:38:59][mtr4] Reading: id=Power/StringItentifier: value=852.27 ts=1459539538883
[Apr 01 21:38:59][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539538883
[Apr 01 21:38:59][chn5] Adding reading to queue (value=1.00 ts=1459539538883)
[Apr 01 21:38:59][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:38:59][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:38:59][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:38:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:38:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:39:00][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:00][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:00][d0] Parsed reading (OBIS code=1.8.1, value=018639.8, unit=kWh)
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:39:00][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:00][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:00][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:00][d0] Parsed reading (OBIS code=1.8.2, value=000000.0, unit=kWh)
[Apr 01 21:39:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:39:01][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:01][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:39:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:01][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:01][d0] Parsed reading (OBIS code=2.8.1, value=023289.6, unit=kWh)
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:01][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:39:01][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:39:01][180] ==> number of tuples: 1
[Apr 01 21:39:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:02][d0] Parsed reading (OBIS code=2.8.2, value=000000.0, unit=kWh)
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:39:02][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:39:03][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:03][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:03][d0] Parsed reading (OBIS code=1.8.0, value=018639.8, unit=kWh)
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:39:03][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:39:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:39:03][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:39:03][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:39:03][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:39:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:04][d0] Parsed reading (OBIS code=2.8.0, value=023289.6, unit=kWh)
[Apr 01 21:39:04][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:04][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:39:04][d0] Read package with 8 tuples (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:39:04][mtr0] Got 8 new readings from meter:
[Apr 01 21:39:04][mtr0] Reading: id=255-255:97.97.255*255/ObisItentifier:255-255:97.97.255*255 value=0.00 ts=1459539538760
[Apr 01 21:39:04][mtr0] Reading: id=255-255:0.0.0*255/ObisItentifier:255-255:0.0.0*255 value=26789.00 ts=1459539539330
[Apr 01 21:39:04][mtr0] Reading: id=255-255:1.8.1*255/ObisItentifier:255-255:1.8.1*255 value=18639.80 ts=1459539540324
[Apr 01 21:39:04][mtr0] Reading: id=255-255:1.8.2*255/ObisItentifier:255-255:1.8.2*255 value=0.00 ts=1459539540857
[Apr 01 21:39:04][mtr0] Reading: id=255-255:2.8.1*255/ObisItentifier:255-255:2.8.1*255 value=23289.60 ts=1459539541780
[Apr 01 21:39:04][mtr0] Reading: id=255-255:2.8.2*255/ObisItentifier:255-255:2.8.2*255 value=0.00 ts=1459539542656
[Apr 01 21:39:04][mtr0] Reading: id=255-255:1.8.0*255/ObisItentifier:255-255:1.8.0*255 value=18639.80 ts=1459539543188
[Apr 01 21:39:04][mtr0] Reading: id=255-255:2.8.0*255/ObisItentifier:255-255:2.8.0*255 value=23289.60 ts=1459539544102
[Apr 01 21:39:04][chn0] Adding reading to queue (value=18639.80 ts=1459539543188)
[Apr 01 21:39:04][chn1] Adding reading to queue (value=23289.60 ts=1459539544102)
[Apr 01 21:39:04][chn0] Buffer dump (size=1): {18639.8000,}
[Apr 01 21:39:04][chn1] Buffer dump (size=1): {23289.6000,}
[Apr 01 21:39:04][mtr0] Next reading in 60 seconds
[Apr 01 21:39:04][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:04][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:04][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:04][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:04][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:04][mtr2] Reading: id=Power/StringItentifier: value=842.38 ts=1459539544225
[Apr 01 21:39:04][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539544225
[Apr 01 21:39:04][chn3] Adding reading to queue (value=842.38 ts=1459539544225)
[Apr 01 21:39:04][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:04][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:04][mtr3] Reading: id=Power/StringItentifier: value=842.38 ts=1459539544225
[Apr 01 21:39:04][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539544225
[Apr 01 21:39:04][chn4] Adding reading to queue (value=842.38 ts=1459539544225)
[Apr 01 21:39:04][chn4] Buffer dump (size=1): {842.3811,}
[Apr 01 21:39:04][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:04][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:04][mtr4] Reading: id=Power/StringItentifier: value=842.38 ts=1459539544225
[Apr 01 21:39:04][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539544225
[Apr 01 21:39:04][chn5] Adding reading to queue (value=1.00 ts=1459539544225)
[Apr 01 21:39:04][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:10][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:10][mtr2] Reading: id=Power/StringItentifier: value=739.64 ts=1459539550309
[Apr 01 21:39:10][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539550309
[Apr 01 21:39:10][chn3] Adding reading to queue (value=739.64 ts=1459539550309)
[Apr 01 21:39:10][AVG] [0] 842.381129 @ 1459539544225
[Apr 01 21:39:10][AVG] [1] 739.644957 @ 1459539550309
[Apr 01 21:39:10][AVG] [2] RESULT 847.081228 @ 1459539550309
[Apr 01 21:39:10][chn3] Buffer dump (size=1): {847.0812,}
[Apr 01 21:39:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:10][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:10][mtr3] Reading: id=Power/StringItentifier: value=739.64 ts=1459539550309
[Apr 01 21:39:10][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539550309
[Apr 01 21:39:10][chn4] Adding reading to queue (value=739.64 ts=1459539550309)
[Apr 01 21:39:10][chn4] Buffer dump (size=1): {739.6450,}
[Apr 01 21:39:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:10][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:10][mtr4] Reading: id=Power/StringItentifier: value=739.52 ts=1459539550310
[Apr 01 21:39:10][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539550310
[Apr 01 21:39:10][chn5] Adding reading to queue (value=1.00 ts=1459539550310)
[Apr 01 21:39:10][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:16][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:16][mtr2] Reading: id=Power/StringItentifier: value=735.29 ts=1459539556429
[Apr 01 21:39:16][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539556429
[Apr 01 21:39:16][chn3] Adding reading to queue (value=735.29 ts=1459539556429)
[Apr 01 21:39:16][AVG] [0] 735.294131 @ 1459539556429
[Apr 01 21:39:16][AVG] [1] RESULT 739.644957 @ 1459539556429
[Apr 01 21:39:16][chn3] Buffer dump (size=1): {739.6450,}
[Apr 01 21:39:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:16][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:16][mtr3] Reading: id=Power/StringItentifier: value=735.41 ts=1459539556428
[Apr 01 21:39:16][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539556428
[Apr 01 21:39:16][chn4] Adding reading to queue (value=735.41 ts=1459539556428)
[Apr 01 21:39:16][chn4] Buffer dump (size=1): {735.4143,}
[Apr 01 21:39:16][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:16][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:16][mtr4] Reading: id=Power/StringItentifier: value=735.53 ts=1459539556428
[Apr 01 21:39:16][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539556428
[Apr 01 21:39:16][chn5] Adding reading to queue (value=1.00 ts=1459539556428)
[Apr 01 21:39:16][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:22][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:22][mtr2] Reading: id=Power/StringItentifier: value=738.79 ts=1459539562520
[Apr 01 21:39:22][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539562520
[Apr 01 21:39:22][chn3] Adding reading to queue (value=738.79 ts=1459539562520)
[Apr 01 21:39:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:22][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:22][mtr3] Reading: id=Power/StringItentifier: value=738.67 ts=1459539562520
[Apr 01 21:39:22][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539562520
[Apr 01 21:39:22][chn4] Adding reading to queue (value=738.67 ts=1459539562520)
[Apr 01 21:39:22][chn4] Buffer dump (size=1): {738.6737,}
[Apr 01 21:39:22][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:22][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:22][mtr4] Reading: id=Power/StringItentifier: value=738.67 ts=1459539562520
[Apr 01 21:39:22][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539562520
[Apr 01 21:39:22][chn5] Adding reading to queue (value=1.00 ts=1459539562520)
[Apr 01 21:39:22][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:28][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:28][mtr2] Reading: id=Power/StringItentifier: value=739.52 ts=1459539568605
[Apr 01 21:39:28][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539568605
[Apr 01 21:39:28][chn3] Adding reading to queue (value=739.52 ts=1459539568605)
[Apr 01 21:39:28][AVG] [0] 738.794934 @ 1459539562520
[Apr 01 21:39:28][AVG] [1] 739.523414 @ 1459539568605
[Apr 01 21:39:28][AVG] [2] RESULT 737.043670 @ 1459539568605
[Apr 01 21:39:28][chn3] Buffer dump (size=1): {737.0437,}
[Apr 01 21:39:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:28][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:28][mtr3] Reading: id=Power/StringItentifier: value=739.64 ts=1459539568604
[Apr 01 21:39:28][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539568604
[Apr 01 21:39:28][chn4] Adding reading to queue (value=739.64 ts=1459539568604)
[Apr 01 21:39:28][chn4] Buffer dump (size=1): {739.6450,}
[Apr 01 21:39:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:28][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:28][mtr4] Reading: id=Power/StringItentifier: value=739.64 ts=1459539568604
[Apr 01 21:39:28][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539568604
[Apr 01 21:39:28][chn5] Adding reading to queue (value=1.00 ts=1459539568604)
[Apr 01 21:39:28][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:34][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:34][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:34][mtr2] Reading: id=Power/StringItentifier: value=738.79 ts=1459539574696
[Apr 01 21:39:34][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539574696
[Apr 01 21:39:34][chn3] Adding reading to queue (value=738.79 ts=1459539574696)
[Apr 01 21:39:34][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:34][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:34][mtr3] Reading: id=Power/StringItentifier: value=738.67 ts=1459539574696
[Apr 01 21:39:34][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539574696
[Apr 01 21:39:34][chn4] Adding reading to queue (value=738.67 ts=1459539574696)
[Apr 01 21:39:34][chn4] Buffer dump (size=1): {738.6737,}
[Apr 01 21:39:34][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:34][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:34][mtr4] Reading: id=Power/StringItentifier: value=738.67 ts=1459539574696
[Apr 01 21:39:34][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539574696
[Apr 01 21:39:34][chn5] Adding reading to queue (value=1.00 ts=1459539574696)
[Apr 01 21:39:34][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:40][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:41][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:41][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:41][mtr2] Reading: id=Power/StringItentifier: value=737.95 ts=1459539580794
[Apr 01 21:39:41][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539580794
[Apr 01 21:39:41][chn3] Adding reading to queue (value=737.95 ts=1459539580794)
[Apr 01 21:39:41][AVG] [0] 738.794963 @ 1459539574696
[Apr 01 21:39:41][AVG] [1] 737.946862 @ 1459539580794
[Apr 01 21:39:41][AVG] [2] RESULT 739.158979 @ 1459539580794
[Apr 01 21:39:41][chn3] Buffer dump (size=1): {739.1590,}
[Apr 01 21:39:41][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:41][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:41][mtr3] Reading: id=Power/StringItentifier: value=737.95 ts=1459539580794
[Apr 01 21:39:41][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539580794
[Apr 01 21:39:41][chn4] Adding reading to queue (value=737.95 ts=1459539580794)
[Apr 01 21:39:41][chn4] Buffer dump (size=1): {737.9469,}
[Apr 01 21:39:41][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:41][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:41][mtr4] Reading: id=Power/StringItentifier: value=737.95 ts=1459539580794
[Apr 01 21:39:41][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539580794
[Apr 01 21:39:41][chn5] Adding reading to queue (value=1.00 ts=1459539580794)
[Apr 01 21:39:41][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:46][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:47][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:47][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:47][mtr2] Reading: id=Power/StringItentifier: value=735.29 ts=1459539586914
[Apr 01 21:39:47][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539586914
[Apr 01 21:39:47][chn3] Adding reading to queue (value=735.29 ts=1459539586914)
[Apr 01 21:39:47][AVG] [0] 735.294103 @ 1459539586914
[Apr 01 21:39:47][AVG] [1] RESULT 737.946862 @ 1459539586914
[Apr 01 21:39:47][chn3] Buffer dump (size=1): {737.9469,}
[Apr 01 21:39:47][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:47][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:47][mtr3] Reading: id=Power/StringItentifier: value=735.29 ts=1459539586914
[Apr 01 21:39:47][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539586914
[Apr 01 21:39:47][chn4] Adding reading to queue (value=735.29 ts=1459539586914)
[Apr 01 21:39:47][chn4] Buffer dump (size=1): {735.2941,}
[Apr 01 21:39:47][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:47][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:47][mtr4] Reading: id=Power/StringItentifier: value=735.29 ts=1459539586914
[Apr 01 21:39:47][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539586914
[Apr 01 21:39:47][chn5] Adding reading to queue (value=1.00 ts=1459539586914)
[Apr 01 21:39:47][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:49][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:39:49][e23] ==> number of tuples: 12
[Apr 01 21:39:49][http] Local request received: method=GET url=/e2302 mode=(null)
[Apr 01 21:39:49][e2302]==> number of tuples: 22
[Apr 01 21:39:49][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:39:49][180] ==> number of tuples: 2
[Apr 01 21:39:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:53][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:53][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:53][mtr2] Reading: id=Power/StringItentifier: value=737.10 ts=1459539593019
[Apr 01 21:39:53][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539593019
[Apr 01 21:39:53][chn3] Adding reading to queue (value=737.10 ts=1459539593019)
[Apr 01 21:39:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:53][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:53][mtr3] Reading: id=Power/StringItentifier: value=737.10 ts=1459539593019
[Apr 01 21:39:53][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539593019
[Apr 01 21:39:53][chn4] Adding reading to queue (value=737.10 ts=1459539593019)
[Apr 01 21:39:53][chn4] Buffer dump (size=1): {737.1007,}
[Apr 01 21:39:53][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:53][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:53][mtr4] Reading: id=Power/StringItentifier: value=737.10 ts=1459539593019
[Apr 01 21:39:53][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539593019
[Apr 01 21:39:53][chn5] Adding reading to queue (value=1.00 ts=1459539593019)
[Apr 01 21:39:53][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:39:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:59][mtr2] Got 2 new readings from meter:
[Apr 01 21:39:59][mtr2] Reading: id=Power/StringItentifier: value=733.86 ts=1459539599151
[Apr 01 21:39:59][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539599151
[Apr 01 21:39:59][chn3] Adding reading to queue (value=733.86 ts=1459539599151)
[Apr 01 21:39:59][AVG] [0] 737.100764 @ 1459539593019
[Apr 01 21:39:59][AVG] [1] 733.855161 @ 1459539599151
[Apr 01 21:39:59][AVG] [2] RESULT 736.199426 @ 1459539599151
[Apr 01 21:39:59][chn3] Buffer dump (size=1): {736.1994,}
[Apr 01 21:39:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:59][mtr3] Got 2 new readings from meter:
[Apr 01 21:39:59][mtr3] Reading: id=Power/StringItentifier: value=733.74 ts=1459539599152
[Apr 01 21:39:59][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539599152
[Apr 01 21:39:59][chn4] Adding reading to queue (value=733.74 ts=1459539599152)
[Apr 01 21:39:59][chn4] Buffer dump (size=1): {733.7355,}
[Apr 01 21:39:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:39:59][mtr4] Got 2 new readings from meter:
[Apr 01 21:39:59][mtr4] Reading: id=Power/StringItentifier: value=733.74 ts=1459539599152
[Apr 01 21:39:59][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539599152
[Apr 01 21:39:59][chn5] Adding reading to queue (value=1.00 ts=1459539599152)
[Apr 01 21:39:59][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:39:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:02][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:40:02][180] ==> number of tuples: 2
[Apr 01 21:40:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:04][d0] sending pullsequenz send (len:5 is:5).
[Apr 01 21:40:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:05][d0] Pull answer (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:05][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:05][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:05][mtr2] Reading: id=Power/StringItentifier: value=715.99 ts=1459539605436
[Apr 01 21:40:05][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539605436
[Apr 01 21:40:05][chn3] Adding reading to queue (value=715.99 ts=1459539605436)
[Apr 01 21:40:05][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:05][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:05][mtr3] Reading: id=Power/StringItentifier: value=716.22 ts=1459539605435
[Apr 01 21:40:05][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539605435
[Apr 01 21:40:05][chn4] Adding reading to queue (value=716.22 ts=1459539605435)
[Apr 01 21:40:05][chn4] Buffer dump (size=1): {716.2184,}
[Apr 01 21:40:05][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:05][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:05][mtr4] Reading: id=Power/StringItentifier: value=716.22 ts=1459539605435
[Apr 01 21:40:05][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539605435
[Apr 01 21:40:05][chn5] Adding reading to queue (value=1.00 ts=1459539605435)
[Apr 01 21:40:05][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte  hex= 2
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:40:07][d0] Parsed reading (OBIS code=F.F, value=00000000, unit=)
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:40:07][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:07][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:40:07][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:40:08][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 7 hex= 37
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:40:08][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:40:08][d0] Parsed reading (OBIS code=0.0.0, value= 26789, unit=)
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:40:08][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:40:08][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:08][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:08][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:09][d0] Parsed reading (OBIS code=1.8.1, value=018639.8, unit=kWh)
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:09][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:09][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:09][d0] Parsed reading (OBIS code=1.8.2, value=000000.0, unit=kWh)
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:09][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:40:10][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:40:10][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:10][d0] Parsed reading (OBIS code=2.8.1, value=023289.6, unit=kWh)
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:40:10][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:10][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:11][d0] Parsed reading (OBIS code=2.8.2, value=000000.0, unit=kWh)
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:40:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:11][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:11][mtr2] Reading: id=Power/StringItentifier: value=718.51 ts=1459539611699
[Apr 01 21:40:11][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539611699
[Apr 01 21:40:11][chn3] Adding reading to queue (value=718.51 ts=1459539611699)
[Apr 01 21:40:11][AVG] [0] 715.990471 @ 1459539605436
[Apr 01 21:40:11][AVG] [1] 718.505507 @ 1459539611699
[Apr 01 21:40:11][AVG] [2] RESULT 724.938477 @ 1459539611699
[Apr 01 21:40:11][chn3] Buffer dump (size=1): {724.9385,}
[Apr 01 21:40:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:11][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:11][mtr3] Reading: id=Power/StringItentifier: value=718.39 ts=1459539611699
[Apr 01 21:40:11][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539611699
[Apr 01 21:40:11][chn4] Adding reading to queue (value=718.39 ts=1459539611699)
[Apr 01 21:40:11][chn4] Buffer dump (size=1): {718.3908,}
[Apr 01 21:40:11][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:11][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:11][mtr4] Reading: id=Power/StringItentifier: value=718.39 ts=1459539611699
[Apr 01 21:40:11][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539611699
[Apr 01 21:40:11][chn5] Adding reading to queue (value=1.00 ts=1459539611699)
[Apr 01 21:40:11][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:40:11][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:11][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:11][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:11][d0] Parsed reading (OBIS code=1.8.0, value=018639.8, unit=kWh)
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:40:12][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:40:12][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:40:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:12][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:40:12][d0] Parsed reading (OBIS code=2.8.0, value=023289.6, unit=kWh)
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:12][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:40:12][d0] Read package with 8 tuples (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:40:12][mtr0] Got 8 new readings from meter:
[Apr 01 21:40:12][mtr0] Reading: id=255-255:97.97.255*255/ObisItentifier:255-255:97.97.255*255 value=0.00 ts=1459539607480
[Apr 01 21:40:12][mtr0] Reading: id=255-255:0.0.0*255/ObisItentifier:255-255:0.0.0*255 value=26789.00 ts=1459539608135
[Apr 01 21:40:12][mtr0] Reading: id=255-255:1.8.1*255/ObisItentifier:255-255:1.8.1*255 value=18639.80 ts=1459539609042
[Apr 01 21:40:12][mtr0] Reading: id=255-255:1.8.2*255/ObisItentifier:255-255:1.8.2*255 value=0.00 ts=1459539609908
[Apr 01 21:40:12][mtr0] Reading: id=255-255:2.8.1*255/ObisItentifier:255-255:2.8.1*255 value=23289.60 ts=1459539610441
[Apr 01 21:40:12][mtr0] Reading: id=255-255:2.8.2*255/ObisItentifier:255-255:2.8.2*255 value=0.00 ts=1459539611458
[Apr 01 21:40:12][mtr0] Reading: id=255-255:1.8.0*255/ObisItentifier:255-255:1.8.0*255 value=18639.80 ts=1459539611991
[Apr 01 21:40:12][mtr0] Reading: id=255-255:2.8.0*255/ObisItentifier:255-255:2.8.0*255 value=23289.60 ts=1459539612909
[Apr 01 21:40:12][chn0] Adding reading to queue (value=18639.80 ts=1459539611991)
[Apr 01 21:40:12][chn1] Adding reading to queue (value=23289.60 ts=1459539612909)
[Apr 01 21:40:12][chn0] Buffer dump (size=1): {18639.8000,}
[Apr 01 21:40:12][chn1] Buffer dump (size=1): {23289.6000,}
[Apr 01 21:40:12][mtr0] Next reading in 60 seconds
[Apr 01 21:40:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:18][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:18][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:18][mtr2] Reading: id=Power/StringItentifier: value=714.51 ts=1459539617997
[Apr 01 21:40:18][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539617997
[Apr 01 21:40:18][chn3] Adding reading to queue (value=714.51 ts=1459539617997)
[Apr 01 21:40:18][AVG] [0] 714.512533 @ 1459539617997
[Apr 01 21:40:18][AVG] [1] RESULT 718.505507 @ 1459539617997
[Apr 01 21:40:18][chn3] Buffer dump (size=1): {718.5055,}
[Apr 01 21:40:18][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:18][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:18][mtr3] Reading: id=Power/StringItentifier: value=714.51 ts=1459539617997
[Apr 01 21:40:18][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539617997
[Apr 01 21:40:18][chn4] Adding reading to queue (value=714.51 ts=1459539617997)
[Apr 01 21:40:18][chn4] Buffer dump (size=1): {714.5125,}
[Apr 01 21:40:18][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:18][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:18][mtr4] Reading: id=Power/StringItentifier: value=714.63 ts=1459539617996
[Apr 01 21:40:18][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539617996
[Apr 01 21:40:18][chn5] Adding reading to queue (value=1.00 ts=1459539617996)
[Apr 01 21:40:18][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:24][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:24][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:24][mtr2] Reading: id=Power/StringItentifier: value=718.62 ts=1459539624259
[Apr 01 21:40:24][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539624259
[Apr 01 21:40:24][chn3] Adding reading to queue (value=718.62 ts=1459539624259)
[Apr 01 21:40:24][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:24][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:24][mtr3] Reading: id=Power/StringItentifier: value=718.51 ts=1459539624260
[Apr 01 21:40:24][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539624260
[Apr 01 21:40:24][chn4] Adding reading to queue (value=718.51 ts=1459539624260)
[Apr 01 21:40:24][chn4] Buffer dump (size=1): {718.5055,}
[Apr 01 21:40:24][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:24][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:24][mtr4] Reading: id=Power/StringItentifier: value=718.39 ts=1459539624260
[Apr 01 21:40:24][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539624260
[Apr 01 21:40:24][chn5] Adding reading to queue (value=1.00 ts=1459539624260)
[Apr 01 21:40:24][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:30][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:30][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:30][mtr2] Reading: id=Power/StringItentifier: value=715.99 ts=1459539630544
[Apr 01 21:40:30][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539630544
[Apr 01 21:40:30][chn3] Adding reading to queue (value=715.99 ts=1459539630544)
[Apr 01 21:40:30][AVG] [0] 718.620267 @ 1459539624259
[Apr 01 21:40:30][AVG] [1] 715.990444 @ 1459539630544
[Apr 01 21:40:30][AVG] [2] RESULT 716.570165 @ 1459539630544
[Apr 01 21:40:30][chn3] Buffer dump (size=1): {716.5702,}
[Apr 01 21:40:30][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:30][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:30][mtr3] Reading: id=Power/StringItentifier: value=716.10 ts=1459539630544
[Apr 01 21:40:30][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539630544
[Apr 01 21:40:30][chn4] Adding reading to queue (value=716.10 ts=1459539630544)
[Apr 01 21:40:30][chn4] Buffer dump (size=1): {716.1044,}
[Apr 01 21:40:30][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:30][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:30][mtr4] Reading: id=Power/StringItentifier: value=716.22 ts=1459539630543
[Apr 01 21:40:30][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539630543
[Apr 01 21:40:30][chn5] Adding reading to queue (value=1.00 ts=1459539630543)
[Apr 01 21:40:30][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:36][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:37][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:37][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:37][mtr2] Reading: id=Power/StringItentifier: value=716.22 ts=1459539636827
[Apr 01 21:40:37][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539636827
[Apr 01 21:40:37][chn3] Adding reading to queue (value=716.22 ts=1459539636827)
[Apr 01 21:40:37][AVG] [0] 716.218368 @ 1459539636827
[Apr 01 21:40:37][AVG] [1] RESULT 715.990444 @ 1459539636827
[Apr 01 21:40:37][chn3] Buffer dump (size=1): {715.9904,}
[Apr 01 21:40:37][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:37][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:37][mtr3] Reading: id=Power/StringItentifier: value=716.22 ts=1459539636827
[Apr 01 21:40:37][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539636827
[Apr 01 21:40:37][chn4] Adding reading to queue (value=716.22 ts=1459539636827)
[Apr 01 21:40:37][chn4] Buffer dump (size=1): {716.2184,}
[Apr 01 21:40:37][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:37][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:37][mtr4] Reading: id=Power/StringItentifier: value=715.99 ts=1459539636828
[Apr 01 21:40:37][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539636828
[Apr 01 21:40:37][chn5] Adding reading to queue (value=1.00 ts=1459539636828)
[Apr 01 21:40:37][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:43][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:43][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:43][mtr2] Reading: id=Power/StringItentifier: value=722.31 ts=1459539643057
[Apr 01 21:40:43][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539643057
[Apr 01 21:40:43][chn3] Adding reading to queue (value=722.31 ts=1459539643057)
[Apr 01 21:40:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:43][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:43][mtr3] Reading: id=Power/StringItentifier: value=722.43 ts=1459539643056
[Apr 01 21:40:43][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539643056
[Apr 01 21:40:43][chn4] Adding reading to queue (value=722.43 ts=1459539643056)
[Apr 01 21:40:43][chn4] Buffer dump (size=1): {722.4273,}
[Apr 01 21:40:43][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:43][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:43][mtr4] Reading: id=Power/StringItentifier: value=722.54 ts=1459539643056
[Apr 01 21:40:43][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539643056
[Apr 01 21:40:43][chn5] Adding reading to queue (value=1.00 ts=1459539643056)
[Apr 01 21:40:43][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:49][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:49][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:49][mtr2] Reading: id=Power/StringItentifier: value=722.54 ts=1459539649285
[Apr 01 21:40:49][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539649285
[Apr 01 21:40:49][chn3] Adding reading to queue (value=722.54 ts=1459539649285)
[Apr 01 21:40:49][AVG] [0] 722.311394 @ 1459539643057
[Apr 01 21:40:49][AVG] [1] 722.543361 @ 1459539649285
[Apr 01 21:40:49][AVG] [2] RESULT 719.264392 @ 1459539649285
[Apr 01 21:40:49][chn3] Buffer dump (size=1): {719.2644,}
[Apr 01 21:40:49][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:49][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:49][mtr3] Reading: id=Power/StringItentifier: value=722.43 ts=1459539649285
[Apr 01 21:40:49][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539649285
[Apr 01 21:40:49][chn4] Adding reading to queue (value=722.43 ts=1459539649285)
[Apr 01 21:40:49][chn4] Buffer dump (size=1): {722.4274,}
[Apr 01 21:40:49][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:49][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:49][mtr4] Reading: id=Power/StringItentifier: value=722.43 ts=1459539649285
[Apr 01 21:40:49][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539649285
[Apr 01 21:40:49][chn5] Adding reading to queue (value=1.00 ts=1459539649285)
[Apr 01 21:40:49][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:49][http] Local request received: method=GET url=/e18 mode=(null)
[Apr 01 21:40:49][e18] ==> number of tuples: 0
[Apr 01 21:40:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:49][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:40:49][e23] ==> number of tuples: 18
[Apr 01 21:40:49][http] Local request received: method=GET url=/e2302 mode=(null)
[Apr 01 21:40:49][e2302]==> number of tuples: 32
[Apr 01 21:40:49][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:40:49][180] ==> number of tuples: 3
[Apr 01 21:40:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:52][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:40:52][e23] ==> number of tuples: 18
[Apr 01 21:40:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:40:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:55][mtr2] Got 2 new readings from meter:
[Apr 01 21:40:55][mtr2] Reading: id=Power/StringItentifier: value=720.69 ts=1459539655529
[Apr 01 21:40:55][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539655529
[Apr 01 21:40:55][chn3] Adding reading to queue (value=720.69 ts=1459539655529)
[Apr 01 21:40:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:55][mtr3] Got 2 new readings from meter:
[Apr 01 21:40:55][mtr3] Reading: id=Power/StringItentifier: value=720.81 ts=1459539655528
[Apr 01 21:40:55][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539655528
[Apr 01 21:40:55][chn4] Adding reading to queue (value=720.81 ts=1459539655528)
[Apr 01 21:40:55][chn4] Buffer dump (size=1): {720.8073,}
[Apr 01 21:40:55][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:40:55][mtr4] Got 2 new readings from meter:
[Apr 01 21:40:55][mtr4] Reading: id=Power/StringItentifier: value=720.81 ts=1459539655528
[Apr 01 21:40:55][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539655528
[Apr 01 21:40:55][chn5] Adding reading to queue (value=1.00 ts=1459539655528)
[Apr 01 21:40:55][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:40:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:40:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:02][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:02][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:02][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:02][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:02][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:02][mtr2] Reading: id=Power/StringItentifier: value=664.60 ts=1459539662300
[Apr 01 21:41:02][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539662300
[Apr 01 21:41:02][chn3] Adding reading to queue (value=664.60 ts=1459539662300)
[Apr 01 21:41:02][AVG] [0] 720.691869 @ 1459539655529
[Apr 01 21:41:02][AVG] [1] 664.599011 @ 1459539662300
[Apr 01 21:41:02][AVG] [2] RESULT 721.580130 @ 1459539662300
[Apr 01 21:41:02][chn3] Buffer dump (size=1): {721.5801,}
[Apr 01 21:41:02][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:02][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:02][mtr3] Reading: id=Power/StringItentifier: value=664.50 ts=1459539662300
[Apr 01 21:41:02][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539662300
[Apr 01 21:41:02][chn4] Adding reading to queue (value=664.50 ts=1459539662300)
[Apr 01 21:41:02][chn4] Buffer dump (size=1): {664.5009,}
[Apr 01 21:41:02][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:02][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:02][mtr4] Reading: id=Power/StringItentifier: value=664.50 ts=1459539662300
[Apr 01 21:41:02][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539662300
[Apr 01 21:41:02][chn5] Adding reading to queue (value=1.00 ts=1459539662300)
[Apr 01 21:41:02][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:03][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:41:03][180] ==> number of tuples: 3
[Apr 01 21:41:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:09][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:10][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:10][mtr2] Reading: id=Power/StringItentifier: value=589.08 ts=1459539669939
[Apr 01 21:41:10][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539669939
[Apr 01 21:41:10][chn3] Adding reading to queue (value=589.08 ts=1459539669939)
[Apr 01 21:41:10][AVG] [0] 589.082345 @ 1459539669939
[Apr 01 21:41:10][AVG] [1] RESULT 664.599011 @ 1459539669939
[Apr 01 21:41:10][chn3] Buffer dump (size=1): {664.5990,}
[Apr 01 21:41:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:10][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:10][mtr3] Reading: id=Power/StringItentifier: value=589.16 ts=1459539669938
[Apr 01 21:41:10][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539669938
[Apr 01 21:41:10][chn4] Adding reading to queue (value=589.16 ts=1459539669938)
[Apr 01 21:41:10][chn4] Buffer dump (size=1): {589.1595,}
[Apr 01 21:41:10][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:10][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:10][mtr4] Reading: id=Power/StringItentifier: value=589.16 ts=1459539669938
[Apr 01 21:41:10][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539669938
[Apr 01 21:41:10][chn5] Adding reading to queue (value=1.00 ts=1459539669938)
[Apr 01 21:41:10][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:12][d0] sending pullsequenz send (len:5 is:5).
[Apr 01 21:41:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:14][d0] Pull answer (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:41:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte  hex= 2
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:41:16][d0] Parsed reading (OBIS code=F.F, value=00000000, unit=)
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:16][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:41:16][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:41:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:16][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 7 hex= 37
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:16][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:41:16][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:41:16][d0] Parsed reading (OBIS code=0.0.0, value= 26789, unit=)
[Apr 01 21:41:16][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:41:17][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:17][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:17][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:17][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:17][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:17][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:17][mtr2] Reading: id=Power/StringItentifier: value=582.90 ts=1459539677659
[Apr 01 21:41:17][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539677659
[Apr 01 21:41:17][chn3] Adding reading to queue (value=582.90 ts=1459539677659)
[Apr 01 21:41:17][AVG] [0] 582.901552 @ 1459539677659
[Apr 01 21:41:17][AVG] [1] RESULT 589.082345 @ 1459539677659
[Apr 01 21:41:17][chn3] Buffer dump (size=1): {589.0823,}
[Apr 01 21:41:17][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:17][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:17][mtr3] Reading: id=Power/StringItentifier: value=582.83 ts=1459539677659
[Apr 01 21:41:17][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539677659
[Apr 01 21:41:17][chn4] Adding reading to queue (value=582.83 ts=1459539677659)
[Apr 01 21:41:17][chn4] Buffer dump (size=1): {582.8261,}
[Apr 01 21:41:17][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:17][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:17][mtr4] Reading: id=Power/StringItentifier: value=582.83 ts=1459539677659
[Apr 01 21:41:17][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539677659
[Apr 01 21:41:17][chn5] Adding reading to queue (value=1.00 ts=1459539677659)
[Apr 01 21:41:17][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:17][d0] Parsed reading (OBIS code=1.8.1, value=018639.8, unit=kWh)
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:17][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:18][d0] Parsed reading (OBIS code=1.8.2, value=000000.0, unit=kWh)
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:41:18][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:41:18][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:41:19][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:41:19][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:19][d0] Parsed reading (OBIS code=2.8.1, value=023289.6, unit=kWh)
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:41:19][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:19][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:20][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:20][d0] Parsed reading (OBIS code=2.8.2, value=000000.0, unit=kWh)
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:41:20][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:20][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:20][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:20][d0] Parsed reading (OBIS code=1.8.0, value=018639.8, unit=kWh)
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:41:20][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:41:21][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:41:21][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:41:21][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:41:21][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:41:21][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:41:21][d0] Parsed reading (OBIS code=2.8.0, value=023289.6, unit=kWh)
[Apr 01 21:41:21][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:21][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:41:21][d0] Read package with 8 tuples (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:41:21][mtr0] Got 8 new readings from meter:
[Apr 01 21:41:21][mtr0] Reading: id=255-255:97.97.255*255/ObisItentifier:255-255:97.97.255*255 value=0.00 ts=1459539676291
[Apr 01 21:41:21][mtr0] Reading: id=255-255:0.0.0*255/ObisItentifier:255-255:0.0.0*255 value=26789.00 ts=1459539676860
[Apr 01 21:41:21][mtr0] Reading: id=255-255:1.8.1*255/ObisItentifier:255-255:1.8.1*255 value=18639.80 ts=1459539677757
[Apr 01 21:41:21][mtr0] Reading: id=255-255:1.8.2*255/ObisItentifier:255-255:1.8.2*255 value=0.00 ts=1459539678622
[Apr 01 21:41:21][mtr0] Reading: id=255-255:2.8.1*255/ObisItentifier:255-255:2.8.1*255 value=23289.60 ts=1459539679154
[Apr 01 21:41:21][mtr0] Reading: id=255-255:2.8.2*255/ObisItentifier:255-255:2.8.2*255 value=0.00 ts=1459539680087
[Apr 01 21:41:21][mtr0] Reading: id=255-255:1.8.0*255/ObisItentifier:255-255:1.8.0*255 value=18639.80 ts=1459539680966
[Apr 01 21:41:21][mtr0] Reading: id=255-255:2.8.0*255/ObisItentifier:255-255:2.8.0*255 value=23289.60 ts=1459539681498
[Apr 01 21:41:21][chn0] Adding reading to queue (value=18639.80 ts=1459539680966)
[Apr 01 21:41:21][chn1] Adding reading to queue (value=23289.60 ts=1459539681498)
[Apr 01 21:41:21][chn0] Buffer dump (size=1): {18639.8000,}
[Apr 01 21:41:21][chn1] Buffer dump (size=1): {23289.6000,}
[Apr 01 21:41:21][mtr0] Next reading in 60 seconds
[Apr 01 21:41:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:25][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:25][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:25][mtr2] Reading: id=Power/StringItentifier: value=631.14 ts=1459539684789
[Apr 01 21:41:25][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539684789
[Apr 01 21:41:25][chn3] Adding reading to queue (value=631.14 ts=1459539684789)
[Apr 01 21:41:25][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:25][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:25][mtr3] Reading: id=Power/StringItentifier: value=631.14 ts=1459539684789
[Apr 01 21:41:25][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539684789
[Apr 01 21:41:25][chn4] Adding reading to queue (value=631.14 ts=1459539684789)
[Apr 01 21:41:25][chn4] Buffer dump (size=1): {631.1361,}
[Apr 01 21:41:25][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:25][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:25][mtr4] Reading: id=Power/StringItentifier: value=631.22 ts=1459539684788
[Apr 01 21:41:25][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539684788
[Apr 01 21:41:25][chn5] Adding reading to queue (value=1.00 ts=1459539684788)
[Apr 01 21:41:25][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:31][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:31][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:31][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:31][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:31][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:31][mtr2] Reading: id=Power/StringItentifier: value=653.31 ts=1459539691677
[Apr 01 21:41:31][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539691677
[Apr 01 21:41:31][chn3] Adding reading to queue (value=653.31 ts=1459539691677)
[Apr 01 21:41:31][AVG] [0] 631.136035 @ 1459539684789
[Apr 01 21:41:31][AVG] [1] 653.310126 @ 1459539691677
[Apr 01 21:41:31][AVG] [2] RESULT 606.602445 @ 1459539691677
[Apr 01 21:41:31][chn3] Buffer dump (size=1): {606.6024,}
[Apr 01 21:41:31][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:31][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:31][mtr3] Reading: id=Power/StringItentifier: value=653.22 ts=1459539691678
[Apr 01 21:41:31][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539691678
[Apr 01 21:41:31][chn4] Adding reading to queue (value=653.22 ts=1459539691678)
[Apr 01 21:41:31][chn4] Buffer dump (size=1): {653.2153,}
[Apr 01 21:41:31][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:31][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:31][mtr4] Reading: id=Power/StringItentifier: value=653.12 ts=1459539691678
[Apr 01 21:41:31][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539691678
[Apr 01 21:41:31][chn5] Adding reading to queue (value=1.00 ts=1459539691678)
[Apr 01 21:41:31][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:38][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:38][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:38][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:38][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:38][mtr2] Reading: id=Power/StringItentifier: value=658.38 ts=1459539698512
[Apr 01 21:41:38][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539698512
[Apr 01 21:41:38][chn3] Adding reading to queue (value=658.38 ts=1459539698512)
[Apr 01 21:41:38][AVG] [0] 658.376002 @ 1459539698512
[Apr 01 21:41:38][AVG] [1] RESULT 653.310126 @ 1459539698512
[Apr 01 21:41:38][chn3] Buffer dump (size=1): {653.3101,}
[Apr 01 21:41:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:38][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:38][mtr3] Reading: id=Power/StringItentifier: value=658.47 ts=1459539698512
[Apr 01 21:41:38][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539698512
[Apr 01 21:41:38][chn4] Adding reading to queue (value=658.47 ts=1459539698512)
[Apr 01 21:41:38][chn4] Buffer dump (size=1): {658.4724,}
[Apr 01 21:41:38][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:38][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:38][mtr4] Reading: id=Power/StringItentifier: value=658.57 ts=1459539698511
[Apr 01 21:41:38][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539698511
[Apr 01 21:41:38][chn5] Adding reading to queue (value=1.00 ts=1459539698511)
[Apr 01 21:41:38][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:41][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:42][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:43][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:44][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:45][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:45][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:45][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:45][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:45][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:45][mtr2] Reading: id=Power/StringItentifier: value=654.55 ts=1459539705387
[Apr 01 21:41:45][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539705387
[Apr 01 21:41:45][chn3] Adding reading to queue (value=654.55 ts=1459539705387)
[Apr 01 21:41:45][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:45][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:45][mtr3] Reading: id=Power/StringItentifier: value=654.55 ts=1459539705387
[Apr 01 21:41:45][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539705387
[Apr 01 21:41:45][chn4] Adding reading to queue (value=654.55 ts=1459539705387)
[Apr 01 21:41:45][chn4] Buffer dump (size=1): {654.5455,}
[Apr 01 21:41:45][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:45][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:45][mtr4] Reading: id=Power/StringItentifier: value=654.45 ts=1459539705387
[Apr 01 21:41:45][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539705387
[Apr 01 21:41:45][chn5] Adding reading to queue (value=1.00 ts=1459539705387)
[Apr 01 21:41:45][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:45][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:46][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:47][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:48][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:49][http] Local request received: method=GET url=/e18 mode=(null)
[Apr 01 21:41:49][e18] ==> number of tuples: 0
[Apr 01 21:41:49][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:49][http] Local request received: method=GET url=/e23 mode=(null)
[Apr 01 21:41:49][e23] ==> number of tuples: 23
[Apr 01 21:41:49][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:41:49][180] ==> number of tuples: 4
[Apr 01 21:41:49][http] Local request received: method=GET url=/e2302 mode=(null)
[Apr 01 21:41:49][e2302]==> number of tuples: 40
[Apr 01 21:41:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:50][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:51][http] Local request received: method=GET url=/280 mode=(null)
[Apr 01 21:41:51][280] ==> number of tuples: 4
[Apr 01 21:41:51][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:52][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:52][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:52][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:52][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:52][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:52][mtr2] Reading: id=Power/StringItentifier: value=651.89 ts=1459539712290
[Apr 01 21:41:52][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539712290
[Apr 01 21:41:52][chn3] Adding reading to queue (value=651.89 ts=1459539712290)
[Apr 01 21:41:52][AVG] [0] 654.545455 @ 1459539705387
[Apr 01 21:41:52][AVG] [1] 651.890471 @ 1459539712290
[Apr 01 21:41:52][AVG] [2] RESULT 656.456836 @ 1459539712290
[Apr 01 21:41:52][chn3] Buffer dump (size=1): {656.4568,}
[Apr 01 21:41:52][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:52][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:52][mtr3] Reading: id=Power/StringItentifier: value=651.98 ts=1459539712289
[Apr 01 21:41:52][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539712289
[Apr 01 21:41:52][chn4] Adding reading to queue (value=651.98 ts=1459539712289)
[Apr 01 21:41:52][chn4] Buffer dump (size=1): {651.9849,}
[Apr 01 21:41:52][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:52][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:52][mtr4] Reading: id=Power/StringItentifier: value=651.98 ts=1459539712289
[Apr 01 21:41:52][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539712289
[Apr 01 21:41:52][chn5] Adding reading to queue (value=1.00 ts=1459539712289)
[Apr 01 21:41:52][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:52][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:53][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:54][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:55][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:56][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:57][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:58][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:41:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:59][mtr2] Got 2 new readings from meter:
[Apr 01 21:41:59][mtr2] Reading: id=Power/StringItentifier: value=612.91 ts=1459539719632
[Apr 01 21:41:59][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539719632
[Apr 01 21:41:59][chn3] Adding reading to queue (value=612.91 ts=1459539719632)
[Apr 01 21:41:59][AVG] [0] 612.912012 @ 1459539719632
[Apr 01 21:41:59][AVG] [1] RESULT 651.890471 @ 1459539719632
[Apr 01 21:41:59][chn3] Buffer dump (size=1): {651.8905,}
[Apr 01 21:41:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:59][mtr3] Got 2 new readings from meter:
[Apr 01 21:41:59][mtr3] Reading: id=Power/StringItentifier: value=612.83 ts=1459539719632
[Apr 01 21:41:59][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539719632
[Apr 01 21:41:59][chn4] Adding reading to queue (value=612.83 ts=1459539719632)
[Apr 01 21:41:59][chn4] Buffer dump (size=1): {612.8285,}
[Apr 01 21:41:59][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:41:59][mtr4] Got 2 new readings from meter:
[Apr 01 21:41:59][mtr4] Reading: id=Power/StringItentifier: value=612.83 ts=1459539719632
[Apr 01 21:41:59][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539719632
[Apr 01 21:41:59][chn5] Adding reading to queue (value=1.00 ts=1459539719632)
[Apr 01 21:41:59][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:41:59][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:00][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:01][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:02][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:03][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:04][http] Local request received: method=GET url=/180 mode=(null)
[Apr 01 21:42:04][180] ==> number of tuples: 4
[Apr 01 21:42:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:04][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:05][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:06][mtr2] Got 2 new readings from meter:
[Apr 01 21:42:06][mtr2] Reading: id=Power/StringItentifier: value=636.04 ts=1459539726707
[Apr 01 21:42:06][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539726707
[Apr 01 21:42:06][chn3] Adding reading to queue (value=636.04 ts=1459539726707)
[Apr 01 21:42:06][AVG] [0] 636.042399 @ 1459539726707
[Apr 01 21:42:06][AVG] [1] RESULT 612.912012 @ 1459539726707
[Apr 01 21:42:06][chn3] Buffer dump (size=1): {612.9120,}
[Apr 01 21:42:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:06][mtr3] Got 2 new readings from meter:
[Apr 01 21:42:06][mtr3] Reading: id=Power/StringItentifier: value=636.13 ts=1459539726706
[Apr 01 21:42:06][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539726706
[Apr 01 21:42:06][chn4] Adding reading to queue (value=636.13 ts=1459539726706)
[Apr 01 21:42:06][chn4] Buffer dump (size=1): {636.1323,}
[Apr 01 21:42:06][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:06][mtr4] Got 2 new readings from meter:
[Apr 01 21:42:06][mtr4] Reading: id=Power/StringItentifier: value=636.13 ts=1459539726706
[Apr 01 21:42:06][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539726706
[Apr 01 21:42:06][chn5] Adding reading to queue (value=1.00 ts=1459539726706)
[Apr 01 21:42:06][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:42:06][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:07][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:08][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:09][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:10][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:11][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:12][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:13][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:14][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:14][mtr2] Got 2 new readings from meter:
[Apr 01 21:42:14][mtr2] Reading: id=Power/StringItentifier: value=636.13 ts=1459539733781
[Apr 01 21:42:14][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539733781
[Apr 01 21:42:14][chn3] Adding reading to queue (value=636.13 ts=1459539733781)
[Apr 01 21:42:14][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:14][mtr3] Got 2 new readings from meter:
[Apr 01 21:42:14][mtr3] Reading: id=Power/StringItentifier: value=636.04 ts=1459539733781
[Apr 01 21:42:14][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539733781
[Apr 01 21:42:14][chn4] Adding reading to queue (value=636.04 ts=1459539733781)
[Apr 01 21:42:14][chn4] Buffer dump (size=1): {636.0424,}
[Apr 01 21:42:14][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:14][mtr4] Got 2 new readings from meter:
[Apr 01 21:42:14][mtr4] Reading: id=Power/StringItentifier: value=636.04 ts=1459539733781
[Apr 01 21:42:14][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539733781
[Apr 01 21:42:14][chn5] Adding reading to queue (value=1.00 ts=1459539733781)
[Apr 01 21:42:14][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:42:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:14][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:15][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:16][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:17][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:18][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:19][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:20][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:21][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:21][mtr2] Got 2 new readings from meter:
[Apr 01 21:42:21][mtr2] Reading: id=Power/StringItentifier: value=627.53 ts=1459539740952
[Apr 01 21:42:21][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539740952
[Apr 01 21:42:21][chn3] Adding reading to queue (value=627.53 ts=1459539740952)
[Apr 01 21:42:21][AVG] [0] 636.132326 @ 1459539733781
[Apr 01 21:42:21][AVG] [1] 627.527541 @ 1459539740952
[Apr 01 21:42:21][AVG] [2] RESULT 636.087669 @ 1459539740952
[Apr 01 21:42:21][chn3] Buffer dump (size=1): {636.0877,}
[Apr 01 21:42:21][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:21][mtr3] Got 2 new readings from meter:
[Apr 01 21:42:21][mtr3] Reading: id=Power/StringItentifier: value=627.62 ts=1459539740951
[Apr 01 21:42:21][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539740951
[Apr 01 21:42:21][chn4] Adding reading to queue (value=627.62 ts=1459539740951)
[Apr 01 21:42:21][chn4] Buffer dump (size=1): {627.6151,}
[Apr 01 21:42:21][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:21][mtr4] Got 2 new readings from meter:
[Apr 01 21:42:21][mtr4] Reading: id=Power/StringItentifier: value=627.62 ts=1459539740951
[Apr 01 21:42:21][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539740951
[Apr 01 21:42:21][chn5] Adding reading to queue (value=1.00 ts=1459539740951)
[Apr 01 21:42:21][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:42:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:21][d0] sending pullsequenz send (len:5 is:5).
[Apr 01 21:42:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:21][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:22][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:23][d0] Pull answer (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:42:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:23][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:24][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:24][d0] DEBUG OBIS_CODE byte  hex= 2
[Apr 01 21:42:24][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:42:24][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:24][d0] DEBUG OBIS_CODE byte F hex= 46
[Apr 01 21:42:24][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:24][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:24][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:24][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:42:25][d0] Parsed reading (OBIS code=F.F, value=00000000, unit=)
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:25][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:42:25][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:42:25][d0] DEBUG VALUE byte= hex= 20
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 7 hex= 37
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:25][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:42:25][d0] DEBUG VALUE byte= ) hex= 29
[Apr 01 21:42:25][d0] Parsed reading (OBIS code=0.0.0, value= 26789, unit=)
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:25][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:25][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:42:26][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:26][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:26][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:26][d0] Parsed reading (OBIS code=1.8.1, value=018639.8, unit=kWh)
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:26][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:26][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:27][d0] Parsed reading (OBIS code=1.8.2, value=000000.0, unit=kWh)
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:42:27][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:42:27][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:27][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:42:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:27][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:28][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:28][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:28][d0] Parsed reading (OBIS code=2.8.1, value=023289.6, unit=kWh)
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:42:28][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:28][mtr2] Got 2 new readings from meter:
[Apr 01 21:42:28][mtr2] Reading: id=Power/StringItentifier: value=631.84 ts=1459539748074
[Apr 01 21:42:28][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539748074
[Apr 01 21:42:28][chn3] Adding reading to queue (value=631.84 ts=1459539748074)
[Apr 01 21:42:28][AVG] [0] 631.844989 @ 1459539748074
[Apr 01 21:42:28][AVG] [1] RESULT 627.527541 @ 1459539748074
[Apr 01 21:42:28][chn3] Buffer dump (size=1): {627.5275,}
[Apr 01 21:42:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:28][mtr3] Got 2 new readings from meter:
[Apr 01 21:42:28][mtr3] Reading: id=Power/StringItentifier: value=631.76 ts=1459539748074
[Apr 01 21:42:28][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539748074
[Apr 01 21:42:28][chn4] Adding reading to queue (value=631.76 ts=1459539748074)
[Apr 01 21:42:28][chn4] Buffer dump (size=1): {631.7563,}
[Apr 01 21:42:28][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:28][mtr4] Got 2 new readings from meter:
[Apr 01 21:42:28][mtr4] Reading: id=Power/StringItentifier: value=631.76 ts=1459539748074
[Apr 01 21:42:28][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539748074
[Apr 01 21:42:28][chn5] Adding reading to queue (value=1.00 ts=1459539748074)
[Apr 01 21:42:28][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:28][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:28][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:28][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:29][d0] Parsed reading (OBIS code=2.8.2, value=000000.0, unit=kWh)
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 1 hex= 31
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 1 hex= 31
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:42:29][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:29][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:29][d0] Parsed reading (OBIS code=1.8.0, value=018639.8, unit=kWh)
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:29][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 2 hex= 32
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 8 hex= 38
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte . hex= 2E
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte 0 hex= 30
[Apr 01 21:42:29][d0] DEBUG OBIS_CODE byte ( hex= 28
[Apr 01 21:42:29][d0] DEBUG VALUE byte= 0 hex= 30
[Apr 01 21:42:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 3 hex= 33
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 2 hex= 32
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 8 hex= 38
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 9 hex= 39
[Apr 01 21:42:30][d0] DEBUG VALUE byte= . hex= 2e
[Apr 01 21:42:30][d0] DEBUG VALUE byte= 6 hex= 36
[Apr 01 21:42:30][d0] DEBUG VALUE byte= * hex= 2a
[Apr 01 21:42:30][d0] Parsed reading (OBIS code=2.8.0, value=023289.6, unit=kWh)
[Apr 01 21:42:30][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:30][d0] DEBUG OBIS_CODE byte
hex= A
[Apr 01 21:42:30][d0] Read package with 8 tuples (vendor=LGZ, baudrate=5, identification=\2ZMD120APt.G03)
[Apr 01 21:42:30][mtr0] Got 8 new readings from meter:
[Apr 01 21:42:30][mtr0] Reading: id=255-255:97.97.255*255/ObisItentifier:255-255:97.97.255*255 value=0.00 ts=1459539745221
[Apr 01 21:42:30][mtr0] Reading: id=255-255:0.0.0*255/ObisItentifier:255-255:0.0.0*255 value=26789.00 ts=1459539745790
[Apr 01 21:42:30][mtr0] Reading: id=255-255:1.8.1*255/ObisItentifier:255-255:1.8.1*255 value=18639.80 ts=1459539746786
[Apr 01 21:42:30][mtr0] Reading: id=255-255:1.8.2*255/ObisItentifier:255-255:1.8.2*255 value=0.00 ts=1459539747319
[Apr 01 21:42:30][mtr0] Reading: id=255-255:2.8.1*255/ObisItentifier:255-255:2.8.1*255 value=23289.60 ts=1459539748242
[Apr 01 21:42:30][mtr0] Reading: id=255-255:2.8.2*255/ObisItentifier:255-255:2.8.2*255 value=0.00 ts=1459539749116
[Apr 01 21:42:30][mtr0] Reading: id=255-255:1.8.0*255/ObisItentifier:255-255:1.8.0*255 value=18639.80 ts=1459539749649
[Apr 01 21:42:30][mtr0] Reading: id=255-255:2.8.0*255/ObisItentifier:255-255:2.8.0*255 value=23289.60 ts=1459539750563
[Apr 01 21:42:30][chn0] Adding reading to queue (value=18639.80 ts=1459539749649)
[Apr 01 21:42:30][chn1] Adding reading to queue (value=23289.60 ts=1459539750563)
[Apr 01 21:42:30][chn0] Buffer dump (size=1): {18639.8000,}
[Apr 01 21:42:30][chn1] Buffer dump (size=1): {23289.6000,}
[Apr 01 21:42:30][mtr0] Next reading in 60 seconds
[Apr 01 21:42:30][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:31][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:32][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:33][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:34][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 1
[Apr 01 21:42:35][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:35][mtr2] Got 2 new readings from meter:
[Apr 01 21:42:35][mtr2] Reading: id=Power/StringItentifier: value=638.57 ts=1459539755121
[Apr 01 21:42:35][mtr2] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539755121
[Apr 01 21:42:35][chn3] Adding reading to queue (value=638.57 ts=1459539755121)
[Apr 01 21:42:35][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:35][mtr3] Got 2 new readings from meter:
[Apr 01 21:42:35][mtr3] Reading: id=Power/StringItentifier: value=638.57 ts=1459539755121
[Apr 01 21:42:35][mtr3] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539755121
[Apr 01 21:42:35][chn4] Adding reading to queue (value=638.57 ts=1459539755121)
[Apr 01 21:42:35][chn4] Buffer dump (size=1): {638.5696,}
[Apr 01 21:42:35][s0] Reading S0 - returning 2 readings (n=1 n_neg = 0)
[Apr 01 21:42:35][mtr4] Got 2 new readings from meter:
[Apr 01 21:42:35][mtr4] Reading: id=Power/StringItentifier: value=638.57 ts=1459539755121
[Apr 01 21:42:35][mtr4] Reading: id=Impulse/StringItentifier: value=1.00 ts=1459539755121
[Apr 01 21:42:35][chn5] Adding reading to queue (value=1.00 ts=1459539755121)
[Apr 01 21:42:35][chn5] Buffer dump (size=1): {1.0000,}
[Apr 01 21:42:35][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:36][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:37][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:38][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:39][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
[Apr 01 21:42:40][S0] MeterS0:HWIF_GPIO:first poll returned 0
...
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment