[vz-dev] vzlogger.log läuft voll

Christian Wulff christianwulff at gmx.de
Mon Feb 20 12:38:58 CET 2017


So, hab das mal gemacht.
Komplette vzlogger.conf eingedampft auf:

{
  "retry": 0,
  "daemon": true,
  "verbosity": 15,
  "log": "/tmp/vzlogger.log",
  "local": {
    "enabled": false,
    "port": 8080,
    "index": false,
    "timeout": 0,
    "buffer": 0
  },
  "meters": [
    {
      "enabled": true,
      "allowskip": false,
      "interval": 30,
      "channels": [
       {
          "uuid": "89c0c960-8e59-11e6-81d7-efe19b94c4aa",
          "identifier": "1.8.0",
          "api": "volkszaehler",
          "middleware": "http://localhost/middleware.php",
          "aggmode": "none",
          "duplicates": 3600
        }
      ],
      "protocol": "d0",
      "device": "/dev/ttyUSB1",
	  "dump_file": "/tmp/d0_Strom_Haus.txt",
      "pullseq": "2F3F210D0A",
      "baudrate": 300,
      "parity": "7e1",
      "read_timeout": 60
        
    }
  ]
}


Das Dump File sieht nun so aus:
Die HEX Zahlen sind die Daten, das ist mir klar.
Aber was sind die "##### 24.171468014s" für Werte? Da kann ich mir keinen Reim drauf machen. Ein timestamp scheint das nicht zu sein, weil die Zahlen in den einzelnen Blöcken zueinander nicht stetig größer werden?!


##### 24.171468014s (     0 ms) opened
##### 24.175956921s (     4 ms) read
##### 24.175982754s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 24.176064994s (     1 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 24.208645720s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 36 2a 6b 57 68 29 0a 0a 21                     .6*kWh)  !       

##### 59.437399749s ( 35229 ms) read
##### 59.437445583s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 59.437530270s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 59.468032142s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 36 2a 6b 57 68 29 0a 0a 21                     .6*kWh)  !       

##### 94.730465490s ( 35262 ms) read
##### 94.730496376s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 94.730542001s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 94.762691529s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 36 2a 6b 57 68 29 0a 0a 21                     .6*kWh)  !       

##### 30.012675296s ( 35250 ms) read
##### 30.012707535s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 30.012762535s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 30.045145553s (    33 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 65.315894682s ( 35270 ms) read
##### 65.315944474s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 65.316015203s (     1 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 65.347732961s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

#####  0.647708076s ( 35300 ms) read
#####  0.647745628s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<<  0.647793701s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>>  0.679297344s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 35.953066004s ( 35274 ms) read
##### 35.953099285s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 35.953155587s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 35.985505428s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 71.254258880s ( 35269 ms) read
##### 71.254300234s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 71.254354140s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 71.285584814s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

#####  6.490591294s ( 35205 ms) read
#####  6.490625826s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<<  6.490689159s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>>  6.521812957s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 41.781818754s ( 35260 ms) read
##### 41.781852660s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 41.781909379s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 41.815473907s (    34 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 77.064206424s ( 35249 ms) read
##### 77.064245851s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 77.064298299s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 77.096559390s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 12.335585241s ( 35239 ms) read
##### 12.335614876s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 12.335667116s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 12.367375654s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 47.661372073s ( 35294 ms) read
##### 47.661403948s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 47.661449000s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 47.693456496s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 82.885943550s ( 35192 ms) read
##### 82.885984957s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 82.886025634s (     1 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 82.919773235s (    33 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 18.243532254s ( 35324 ms) read
##### 18.243570848s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 18.243630796s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 18.276108032s (    33 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 37 2a 6b 57 68 29 0a 0a 21                     .7*kWh)  !       

##### 53.457247066s ( 35181 ms) read
##### 53.457278420s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 53.457331754s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 53.489797844s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 88.760998276s ( 35271 ms) read
##### 88.761037286s (     1 ms) TCIOFLUSH and cfsetiospeed
<<<<< 88.761136974s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 88.792416970s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 24.072307193s ( 35280 ms) read
##### 24.072348443s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 24.072422505s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 24.103486824s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 59.274680026s ( 35171 ms) read
##### 59.274710286s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 59.274759557s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 59.308537002s (    34 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 94.613637013s ( 35305 ms) read
##### 94.613668002s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 94.613738992s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 94.644853103s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 29.852338906s ( 35208 ms) read
##### 29.852369531s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 29.852414636s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 29.884795257s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 65.176507144s ( 35292 ms) read
##### 65.176554696s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 65.176641363s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 65.207306933s (    31 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

#####  0.563109544s ( 35356 ms) read
#####  0.563142148s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<<  0.563215689s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>>  0.595967561s (    32 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 35.814817372s ( 35219 ms) read
##### 35.814845445s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 35.814887580s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              

>>>>> 35.847282629s (    33 ms) 
2f 3f 21 0a 0a 2f 41 43 45 30 5c 33 6b 32 36 30   /?!  /ACE0\3k260 
56 30 31 2e 31 39 0a 0a 02 46 2e 46 28 30 30 29   V01.19   F.F(00) 
0a 0a 43 2e 31 28 31 31 32 36 31 32 30 30 35 33     C.1(1126120053 
33 35 35 35 38 31 29 0a 0a 43 2e 35 2e 30 28 30   355581)  C.5.0(0 
30 29 0a 0a 31 2e 38 2e 30 28 30 30 39 36 38 38   0)  1.8.0(009688 
2e 38 2a 6b 57 68 29 0a 0a 21                     .8*kWh)  !       

##### 71.160251807s ( 35313 ms) read
##### 71.160299463s (     0 ms) TCIOFLUSH and cfsetiospeed
<<<<< 71.160388161s (     0 ms) 
2f 3f 21 0d 0a                                    /?!              


Und die vzlogger.log sieht nun so aus:


[Feb 20 10:32:53][main] vzlogger v0.6.0 based on heads/master-0-g1484f9aad1 from Mon, 22 Aug 2016 22:32:51 +0200 started.
[Feb 20 10:32:53][mtr0] Creating new meter with protocol d0.
[Feb 20 10:32:53][d0]   pullseq len:5 found
[Feb 20 10:32:53][mtr0] Meter configured, enabled.
[Feb 20 10:32:53]       New meter initialized (protocol=d0)
[Feb 20 10:32:53]       Configure channel.
[Feb 20 10:32:53][chn0] New channel initialized (uuid=...94c4aa api=volkszaehler id=1.8.0)
[Feb 20 10:32:53]       Have 1 meters.
[Feb 20 10:32:53][main] log level is 15
[Feb 20 10:32:53][main] daemon=1, local=0
[Feb 20 10:32:53]       Daemonize process...
[Feb 20 10:32:53]       Opened logfile /tmp/vzlogger.log
[Feb 20 10:32:53][push] No pushDataServer defined.
[Feb 20 10:32:53][]     ===> Start meters
[Feb 20 10:32:53][mtr0] Meter connection established
[Feb 20 10:32:53][mtr0] Meter thread started
[Feb 20 10:32:53][mtr0] Meter is opened. Starting channels.
[Feb 20 10:32:53][chn0] Logging thread started
[Feb 20 10:32:53][]     Startup done.
[Feb 20 10:32:53][mtr0] Number of readers: 400
[Feb 20 10:32:53][mtr0] Config.daemon: 1
[Feb 20 10:32:53][mtr0] Config.local: 0
[Feb 20 10:32:53][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:32:53][chn0] Start logging thread for volkszaehler-api. Running as daemon: yes
[Feb 20 10:32:53][chn0] Using default volkszaehler api.
[Feb 20 10:32:54][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:32:56][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:32:56][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:32:56][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:06][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:33:06][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:07][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:07][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:33:07][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:08][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:08][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:08][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:33:08][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:08][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:33:08][d0]   Parsed reading (OBIS code=1.8.0, value=009688.6, unit=kWh)
[Feb 20 10:33:08][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:08][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:08][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:33:08][mtr0] Got 4 new readings from meter:
[Feb 20 10:33:08][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583186171
[Feb 20 10:33:08][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583187077
[Feb 20 10:33:08][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583187517
[Feb 20 10:33:08][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.60 ts=1487583188322
[Feb 20 10:33:08][chn0] Adding reading to queue (value=9688.60 ts=1487583188322)
[Feb 20 10:33:08][mtr0] Next reading in 30 seconds
[Feb 20 10:33:08][chn0] ==> number of tuples: 1
[Feb 20 10:33:08][chn0] compare: 0 1487583188322
[Feb 20 10:33:08][chn0] copied 1/1 values for middleware transmission
[Feb 20 10:33:08][chn0] JSON request body: [ [ 1487583188322, 9688.6000000000004 ] ]
[Feb 20 10:33:08][chn0] CURL: Hostname was NOT found in DNS cache
[Feb 20 10:33:08][chn0] CURL:   Trying ::1...
[Feb 20 10:33:08][chn0] CURL: Connected to localhost (::1) port 80 (#0)
[Feb 20 10:33:08][chn0] CURL: Sent 41 bytes.. 
[Feb 20 10:33:08][chn0] CURL: Sent '[ [ 1487583188322, 9688.6000000000004 ] ]' bytes
[Feb 20 10:33:08][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Feb 20 10:33:08][chn0] CURL: HTTP 1.0, assume close after body
[Feb 20 10:33:08][chn0] CURL: Received 26 bytes
[Feb 20 10:33:08][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Feb 20 10:33:08][chn0] CURL: Closing connection 0
[Feb 20 10:33:08][chn0] CURL Request succeeded with code: 200
[Feb 20 10:33:08][chn0] emptied all (1) values
[Feb 20 10:33:38][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:33:39][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:41][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:33:41][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:41][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:42][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:42][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:33:42][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:33:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:33:43][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:33:43][d0]   Parsed reading (OBIS code=1.8.0, value=009688.6, unit=kWh)
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:43][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:33:43][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:33:43][mtr0] Got 4 new readings from meter:
[Feb 20 10:33:43][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583221449
[Feb 20 10:33:43][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583222374
[Feb 20 10:33:43][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583222794
[Feb 20 10:33:43][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.60 ts=1487583223604
[Feb 20 10:33:43][chn0] Adding reading to queue (value=9688.60 ts=1487583223604)
[Feb 20 10:33:43][chn0] ==> number of tuples: 1
[Feb 20 10:33:43][chn0] compare: 1487583188322 1487583223604
[Feb 20 10:33:43][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:33:43][mtr0] Next reading in 30 seconds
[Feb 20 10:34:13][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:34:14][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:16][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:16][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:16][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:16][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:16][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:17][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:34:17][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:18][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:34:18][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:34:18][d0]   Parsed reading (OBIS code=1.8.0, value=009688.6, unit=kWh)
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:19][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:34:19][mtr0] Got 4 new readings from meter:
[Feb 20 10:34:19][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583256729
[Feb 20 10:34:19][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583257634
[Feb 20 10:34:19][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583258051
[Feb 20 10:34:19][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.60 ts=1487583258881
[Feb 20 10:34:19][chn0] Adding reading to queue (value=9688.60 ts=1487583258881)
[Feb 20 10:34:19][chn0] ==> number of tuples: 1
[Feb 20 10:34:19][chn0] compare: 1487583188322 1487583258881
[Feb 20 10:34:19][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:34:19][mtr0] Next reading in 30 seconds
[Feb 20 10:34:49][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:34:50][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:34:51][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:34:51][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:34:51][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:51][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:34:51][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:51][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:51][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:52][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:34:52][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:52][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:34:52][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:34:53][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:34:53][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:34:54][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:34:54][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:34:54][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:34:54][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:54][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:34:54][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:34:54][mtr0] Got 4 new readings from meter:
[Feb 20 10:34:54][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583292018
[Feb 20 10:34:54][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583292932
[Feb 20 10:34:54][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583293356
[Feb 20 10:34:54][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583294198
[Feb 20 10:34:54][chn0] Adding reading to queue (value=9688.70 ts=1487583294198)
[Feb 20 10:34:54][chn0] ==> number of tuples: 1
[Feb 20 10:34:54][chn0] compare: 1487583188322 1487583294198
[Feb 20 10:34:54][chn0] copied 1/1 values for middleware transmission
[Feb 20 10:34:54][chn0] JSON request body: [ [ 1487583294198, 9688.7000000000007 ] ]
[Feb 20 10:34:54][chn0] CURL: Hostname was found in DNS cache
[Feb 20 10:34:54][chn0] CURL: Hostname in DNS cache was stale, zapped
[Feb 20 10:34:54][mtr0] Next reading in 30 seconds
[Feb 20 10:34:54][chn0] CURL:   Trying ::1...
[Feb 20 10:34:54][chn0] CURL: Connected to localhost (::1) port 80 (#1)
[Feb 20 10:34:54][chn0] CURL: Sent 41 bytes.. 
[Feb 20 10:34:54][chn0] CURL: Sent '[ [ 1487583294198, 9688.7000000000007 ] ]' bytes
[Feb 20 10:34:54][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Feb 20 10:34:54][chn0] CURL: HTTP 1.0, assume close after body
[Feb 20 10:34:54][chn0] CURL: Received 26 bytes
[Feb 20 10:34:54][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Feb 20 10:34:54][chn0] CURL: Closing connection 1
[Feb 20 10:34:54][chn0] CURL Request succeeded with code: 200
[Feb 20 10:34:54][chn0] emptied all (1) values
[Feb 20 10:35:24][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:35:25][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:35:27][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:35:27][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:27][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:35:28][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:28][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:35:28][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:35:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:35:29][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:35:29][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:35:29][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:35:29][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:35:29][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:29][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:35:29][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:35:29][mtr0] Got 4 new readings from meter:
[Feb 20 10:35:29][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583327392
[Feb 20 10:35:29][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583328293
[Feb 20 10:35:29][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583328723
[Feb 20 10:35:29][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583329531
[Feb 20 10:35:29][chn0] Adding reading to queue (value=9688.70 ts=1487583329531)
[Feb 20 10:35:29][chn0] ==> number of tuples: 1
[Feb 20 10:35:29][chn0] compare: 1487583294198 1487583329531
[Feb 20 10:35:29][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:35:29][mtr0] Next reading in 30 seconds
[Feb 20 10:35:59][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:36:00][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:02][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:02][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:02][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:02][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:36:02][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:02][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:03][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:36:03][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:04][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:36:04][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:36:04][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:04][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:36:04][mtr0] Got 4 new readings from meter:
[Feb 20 10:36:04][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583362669
[Feb 20 10:36:04][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583363582
[Feb 20 10:36:04][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583364000
[Feb 20 10:36:04][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583364831
[Feb 20 10:36:04][chn0] Adding reading to queue (value=9688.70 ts=1487583364831)
[Feb 20 10:36:04][chn0] ==> number of tuples: 1
[Feb 20 10:36:04][chn0] compare: 1487583294198 1487583364831
[Feb 20 10:36:04][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:36:04][mtr0] Next reading in 30 seconds
[Feb 20 10:36:34][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:36:36][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:36:37][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:36:37][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:36:37][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:37][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:36:37][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:37][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:37][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:38][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:36:38][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:38][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:36:39][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:36:39][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:36:40][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:36:40][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:40][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:36:40][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:36:40][mtr0] Got 4 new readings from meter:
[Feb 20 10:36:40][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583398000
[Feb 20 10:36:40][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583398898
[Feb 20 10:36:40][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583399323
[Feb 20 10:36:40][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583400117
[Feb 20 10:36:40][chn0] Adding reading to queue (value=9688.70 ts=1487583400117)
[Feb 20 10:36:40][chn0] ==> number of tuples: 1
[Feb 20 10:36:40][chn0] compare: 1487583294198 1487583400117
[Feb 20 10:36:40][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:36:40][mtr0] Next reading in 30 seconds
[Feb 20 10:37:10][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:37:11][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:37:12][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:13][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:37:13][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:13][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:14][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:14][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:14][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:37:15][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:37:15][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:37:15][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:15][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:15][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:37:15][mtr0] Got 4 new readings from meter:
[Feb 20 10:37:15][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583433231
[Feb 20 10:37:15][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583434129
[Feb 20 10:37:15][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583434554
[Feb 20 10:37:15][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583435363
[Feb 20 10:37:15][chn0] Adding reading to queue (value=9688.70 ts=1487583435363)
[Feb 20 10:37:15][chn0] ==> number of tuples: 1
[Feb 20 10:37:15][chn0] compare: 1487583294198 1487583435363
[Feb 20 10:37:15][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:37:15][mtr0] Next reading in 30 seconds
[Feb 20 10:37:45][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:37:46][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:48][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:37:48][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:37:48][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:49][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:49][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:37:49][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:49][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:37:50][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:37:50][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:50][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:37:50][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:37:50][mtr0] Got 4 new readings from meter:
[Feb 20 10:37:50][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583468508
[Feb 20 10:37:50][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583469420
[Feb 20 10:37:50][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583469848
[Feb 20 10:37:50][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583470654
[Feb 20 10:37:50][chn0] Adding reading to queue (value=9688.70 ts=1487583470654)
[Feb 20 10:37:50][chn0] ==> number of tuples: 1
[Feb 20 10:37:50][chn0] compare: 1487583294198 1487583470654
[Feb 20 10:37:50][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:37:50][mtr0] Next reading in 30 seconds
[Feb 20 10:38:20][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:38:21][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:23][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:23][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:23][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:38:23][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:23][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:24][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:38:24][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:24][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:38:25][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:38:25][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:38:25][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:38:25][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:26][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:26][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:38:26][mtr0] Got 4 new readings from meter:
[Feb 20 10:38:26][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583503810
[Feb 20 10:38:26][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583504714
[Feb 20 10:38:26][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583505138
[Feb 20 10:38:26][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583505947
[Feb 20 10:38:26][chn0] Adding reading to queue (value=9688.70 ts=1487583505947)
[Feb 20 10:38:26][chn0] ==> number of tuples: 1
[Feb 20 10:38:26][chn0] compare: 1487583294198 1487583505947
[Feb 20 10:38:26][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:38:26][mtr0] Next reading in 30 seconds
[Feb 20 10:38:56][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:38:57][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:38:58][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:38:58][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:38:58][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:58][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:38:58][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:58][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:38:59][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:38:59][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:38:59][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:38:59][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:39:00][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:39:00][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:39:01][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:39:01][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:39:01][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:39:01][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:01][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:01][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:39:01][mtr0] Got 4 new readings from meter:
[Feb 20 10:39:01][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583539069
[Feb 20 10:39:01][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583539986
[Feb 20 10:39:01][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583540401
[Feb 20 10:39:01][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583541220
[Feb 20 10:39:01][chn0] Adding reading to queue (value=9688.70 ts=1487583541220)
[Feb 20 10:39:01][chn0] ==> number of tuples: 1
[Feb 20 10:39:01][chn0] compare: 1487583294198 1487583541220
[Feb 20 10:39:01][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:39:01][mtr0] Next reading in 30 seconds
[Feb 20 10:39:31][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:39:32][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:39:34][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:39:34][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:34][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:39:35][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:35][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:39:35][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:39:35][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:39:36][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:39:36][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:39:36][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:39:36][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:36][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:39:36][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:39:36][mtr0] Got 4 new readings from meter:
[Feb 20 10:39:36][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583574366
[Feb 20 10:39:36][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583575269
[Feb 20 10:39:36][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583575702
[Feb 20 10:39:36][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583576507
[Feb 20 10:39:36][chn0] Adding reading to queue (value=9688.70 ts=1487583576507)
[Feb 20 10:39:36][chn0] ==> number of tuples: 1
[Feb 20 10:39:36][chn0] compare: 1487583294198 1487583576507
[Feb 20 10:39:36][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:39:36][mtr0] Next reading in 30 seconds
[Feb 20 10:40:06][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:40:07][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:09][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:09][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:09][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:09][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:40:09][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:09][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:09][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:10][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:10][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:10][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:40:10][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:40:11][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:40:11][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:11][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:11][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:40:11][mtr0] Got 4 new readings from meter:
[Feb 20 10:40:11][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583609631
[Feb 20 10:40:11][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583610528
[Feb 20 10:40:11][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583610953
[Feb 20 10:40:11][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583611757
[Feb 20 10:40:11][chn0] Adding reading to queue (value=9688.70 ts=1487583611757)
[Feb 20 10:40:11][chn0] ==> number of tuples: 1
[Feb 20 10:40:11][chn0] compare: 1487583294198 1487583611757
[Feb 20 10:40:11][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:40:11][mtr0] Next reading in 30 seconds
[Feb 20 10:40:41][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:40:43][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:44][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:44][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:44][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:44][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:44][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:40:45][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:45][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:40:45][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:40:46][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:40:46][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:40:47][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:40:47][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:47][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:40:47][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:40:47][mtr0] Got 4 new readings from meter:
[Feb 20 10:40:47][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583644908
[Feb 20 10:40:47][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583645819
[Feb 20 10:40:47][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583646238
[Feb 20 10:40:47][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583647114
[Feb 20 10:40:47][chn0] Adding reading to queue (value=9688.70 ts=1487583647114)
[Feb 20 10:40:47][chn0] ==> number of tuples: 1
[Feb 20 10:40:47][chn0] compare: 1487583294198 1487583647114
[Feb 20 10:40:47][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:40:47][mtr0] Next reading in 30 seconds
[Feb 20 10:41:17][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:41:18][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:41:19][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:41:19][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:41:19][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:20][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:41:20][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:20][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:21][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:21][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:21][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= 7 hex= 37 
[Feb 20 10:41:22][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:41:22][d0]   Parsed reading (OBIS code=1.8.0, value=009688.7, unit=kWh)
[Feb 20 10:41:22][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:22][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:22][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:41:22][mtr0] Got 4 new readings from meter:
[Feb 20 10:41:22][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583680182
[Feb 20 10:41:22][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583681091
[Feb 20 10:41:22][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583681525
[Feb 20 10:41:22][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.70 ts=1487583682342
[Feb 20 10:41:22][chn0] Adding reading to queue (value=9688.70 ts=1487583682342)
[Feb 20 10:41:22][mtr0] Next reading in 30 seconds
[Feb 20 10:41:22][chn0] ==> number of tuples: 1
[Feb 20 10:41:22][chn0] compare: 1487583294198 1487583682342
[Feb 20 10:41:22][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:41:52][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:41:53][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:55][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:41:55][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:55][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:56][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:56][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:41:56][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:56][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:41:57][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:41:57][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:57][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:41:57][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:41:57][mtr0] Got 4 new readings from meter:
[Feb 20 10:41:57][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583715459
[Feb 20 10:41:57][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583716367
[Feb 20 10:41:57][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583716796
[Feb 20 10:41:57][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583717631
[Feb 20 10:41:57][chn0] Adding reading to queue (value=9688.80 ts=1487583717631)
[Feb 20 10:41:57][mtr0] Next reading in 30 seconds
[Feb 20 10:41:57][chn0] ==> number of tuples: 1
[Feb 20 10:41:57][chn0] compare: 1487583294198 1487583717631
[Feb 20 10:41:57][chn0] copied 1/1 values for middleware transmission
[Feb 20 10:41:57][chn0] JSON request body: [ [ 1487583717631, 9688.7999999999993 ] ]
[Feb 20 10:41:57][chn0] CURL: Hostname was found in DNS cache
[Feb 20 10:41:57][chn0] CURL: Hostname in DNS cache was stale, zapped
[Feb 20 10:41:57][chn0] CURL:   Trying ::1...
[Feb 20 10:41:57][chn0] CURL: Connected to localhost (::1) port 80 (#2)
[Feb 20 10:41:57][chn0] CURL: Sent 41 bytes.. 
[Feb 20 10:41:57][chn0] CURL: Sent '[ [ 1487583717631, 9688.7999999999993 ] ]' bytes
[Feb 20 10:41:57][chn0] CURL: upload completely sent off: 41 out of 41 bytes
[Feb 20 10:41:57][chn0] CURL: HTTP 1.0, assume close after body
[Feb 20 10:41:57][chn0] CURL: Received 26 bytes
[Feb 20 10:41:57][chn0] CURL: Received '{"version":"0.3","rows":1}' bytes
[Feb 20 10:41:57][chn0] CURL: Closing connection 2
[Feb 20 10:41:57][chn0] CURL Request succeeded with code: 200
[Feb 20 10:41:57][chn0] emptied all (1) values
[Feb 20 10:42:27][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:42:28][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:42:30][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:30][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:30][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:42:30][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:42:30][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:42:31][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:42:31][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:31][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:42:32][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:42:32][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:42:32][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:32][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:42:33][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:42:33][mtr0] Got 4 new readings from meter:
[Feb 20 10:42:33][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583750752
[Feb 20 10:42:33][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583751665
[Feb 20 10:42:33][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583752115
[Feb 20 10:42:33][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583752925
[Feb 20 10:42:33][chn0] Adding reading to queue (value=9688.80 ts=1487583752925)
[Feb 20 10:42:33][chn0] ==> number of tuples: 1
[Feb 20 10:42:33][chn0] compare: 1487583717631 1487583752925
[Feb 20 10:42:33][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:42:33][mtr0] Next reading in 30 seconds
[Feb 20 10:43:03][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:43:04][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:43:05][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:43:05][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:43:05][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:05][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:43:05][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:05][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:05][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:06][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:06][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:06][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:06][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:07][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:43:07][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:08][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:43:08][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:43:08][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:08][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:08][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:43:08][mtr0] Got 4 new readings from meter:
[Feb 20 10:43:08][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583786014
[Feb 20 10:43:08][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583786926
[Feb 20 10:43:08][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583787348
[Feb 20 10:43:08][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583788152
[Feb 20 10:43:08][chn0] Adding reading to queue (value=9688.80 ts=1487583788152)
[Feb 20 10:43:08][chn0] ==> number of tuples: 1
[Feb 20 10:43:08][chn0] compare: 1487583717631 1487583788152
[Feb 20 10:43:08][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:43:08][mtr0] Next reading in 30 seconds
[Feb 20 10:43:38][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:43:39][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:41][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:43:41][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:43:41][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:42][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:42][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:43:42][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:43:42][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:43:43][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:43:43][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:43:43][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:43:43][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:43][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:43:43][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:43:43][mtr0] Got 4 new readings from meter:
[Feb 20 10:43:43][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583821304
[Feb 20 10:43:43][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583822207
[Feb 20 10:43:43][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583822640
[Feb 20 10:43:43][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583823491
[Feb 20 10:43:43][chn0] Adding reading to queue (value=9688.80 ts=1487583823491)
[Feb 20 10:43:43][chn0] ==> number of tuples: 1
[Feb 20 10:43:43][chn0] compare: 1487583717631 1487583823491
[Feb 20 10:43:43][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:43:43][mtr0] Next reading in 30 seconds
[Feb 20 10:44:13][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:44:14][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:16][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:44:16][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:16][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:17][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:17][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:17][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:44:17][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:18][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:44:18][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:18][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:18][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:44:18][mtr0] Got 4 new readings from meter:
[Feb 20 10:44:18][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583856572
[Feb 20 10:44:18][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583857500
[Feb 20 10:44:18][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583857931
[Feb 20 10:44:18][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583858731
[Feb 20 10:44:18][chn0] Adding reading to queue (value=9688.80 ts=1487583858731)
[Feb 20 10:44:18][chn0] ==> number of tuples: 1
[Feb 20 10:44:18][chn0] compare: 1487583717631 1487583858731
[Feb 20 10:44:18][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:44:18][mtr0] Next reading in 30 seconds
[Feb 20 10:44:48][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:44:50][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:51][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:51][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:51][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:51][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:51][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:44:52][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:52][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:44:52][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:44:53][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:44:53][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:44:54][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:44:54][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:54][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:44:54][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:44:54][mtr0] Got 4 new readings from meter:
[Feb 20 10:44:54][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583891867
[Feb 20 10:44:54][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583892793
[Feb 20 10:44:54][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583893219
[Feb 20 10:44:54][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583894055
[Feb 20 10:44:54][chn0] Adding reading to queue (value=9688.80 ts=1487583894055)
[Feb 20 10:44:54][chn0] ==> number of tuples: 1
[Feb 20 10:44:54][chn0] compare: 1487583717631 1487583894055
[Feb 20 10:44:54][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:44:54][mtr0] Next reading in 30 seconds
[Feb 20 10:45:24][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:45:25][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:45:26][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:45:27][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:45:27][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:45:27][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:45:28][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:45:28][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:45:28][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:45:28][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:45:29][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:45:29][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:45:29][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:29][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:45:29][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:45:29][mtr0] Got 4 new readings from meter:
[Feb 20 10:45:29][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583927301
[Feb 20 10:45:29][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583928216
[Feb 20 10:45:29][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583928635
[Feb 20 10:45:29][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583929439
[Feb 20 10:45:29][chn0] Adding reading to queue (value=9688.80 ts=1487583929439)
[Feb 20 10:45:29][chn0] ==> number of tuples: 1
[Feb 20 10:45:29][chn0] compare: 1487583717631 1487583929439
[Feb 20 10:45:29][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:45:29][mtr0] Next reading in 30 seconds
[Feb 20 10:45:59][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:46:00][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:02][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:46:02][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:46:02][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:03][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:03][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:03][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:03][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:04][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:46:04][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:04][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:04][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:46:04][mtr0] Got 4 new readings from meter:
[Feb 20 10:46:04][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583962521
[Feb 20 10:46:04][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583963419
[Feb 20 10:46:04][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583963849
[Feb 20 10:46:04][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487583964689
[Feb 20 10:46:04][chn0] Adding reading to queue (value=9688.80 ts=1487583964689)
[Feb 20 10:46:04][chn0] ==> number of tuples: 1
[Feb 20 10:46:04][chn0] compare: 1487583717631 1487583964689
[Feb 20 10:46:04][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:46:04][mtr0] Next reading in 30 seconds
[Feb 20 10:46:34][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:46:36][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte  hex= 2 
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte F hex= 46 
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:37][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:37][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:37][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:37][d0]   Parsed reading (OBIS code=F.F, value=00, unit=)
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:37][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 2 hex= 32 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 3 hex= 33 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 5 hex= 35 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= 1 hex= 31 
[Feb 20 10:46:38][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:38][d0]   Parsed reading (OBIS code=C.1, value=1126120053355581, unit=)
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte C hex= 43 
[Feb 20 10:46:38][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 5 hex= 35 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= ) hex= 29 
[Feb 20 10:46:39][d0]   Parsed reading (OBIS code=C.5.0, value=00, unit=)
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 1 hex= 31 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 8 hex= 38 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte . hex= 2E 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG OBIS_CODE byte ( hex= 28 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 0 hex= 30 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 9 hex= 39 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 6 hex= 36 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= . hex= 2e 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= 8 hex= 38 
[Feb 20 10:46:39][d0]   DEBUG VALUE byte= * hex= 2a 
[Feb 20 10:46:40][d0]   Parsed reading (OBIS code=1.8.0, value=009688.8, unit=kWh)
[Feb 20 10:46:40][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:40][d0]   DEBUG OBIS_CODE byte 
 hex= A 
[Feb 20 10:46:40][d0]   Read package with 4 tuples (vendor=ACE, baudrate=0, identification=\3k260V01.19)
[Feb 20 10:46:40][mtr0] Got 4 new readings from meter:
[Feb 20 10:46:40][mtr0] Reading: id=255-255:97.97.255*255/ObisIdentifier:255-255:97.97.255*255 value=0.00 ts=1487583997903
[Feb 20 10:46:40][mtr0] Reading: id=255-255:96.1.255*255/ObisIdentifier:255-255:96.1.255*255 value=1126120053355581.00 ts=1487583998813
[Feb 20 10:46:40][mtr0] Reading: id=255-255:96.5.0*255/ObisIdentifier:255-255:96.5.0*255 value=0.00 ts=1487583999238
[Feb 20 10:46:40][mtr0] Reading: id=255-255:1.8.0*255/ObisIdentifier:255-255:1.8.0*255 value=9688.80 ts=1487584000042
[Feb 20 10:46:40][chn0] Adding reading to queue (value=9688.80 ts=1487584000042)
[Feb 20 10:46:40][chn0] ==> number of tuples: 1
[Feb 20 10:46:40][chn0] compare: 1487583717631 1487584000042
[Feb 20 10:46:40][chn0] JSON request body is null. Nothing to send now.
[Feb 20 10:46:40][mtr0] Next reading in 30 seconds
[Feb 20 10:47:10][d0]   sending pullsequenz send (len:5 is:5).
[Feb 20 10:47:11][d0]   Pull answer (vendor=ACE, baudrate=0, identification=\3k260V01.19)





-----Ursprüngliche Nachricht-----
Von: Christian Wulff [mailto:christianwulff at gmx.de] 
Gesendet: Sonntag, 19. Februar 2017 22:59
An: 'volkszaehler.org'
Betreff: Re: [vz-dev] vzlogger.log läuft voll

Hallo Frank,

Jain...
Ich hab die Zeiten nachgerechnet. Vorhin waren das grob 30 Sekunden, allerdings waren da auch ein paar Ausreißer mit grob 90 Sekunden dabei.
Aktuell sieht das aber anders aus.

Wäre folgendes eine sinnvolle Vorgehensweise?
aggtime, aggmode und aggfixedinterval komplett rausnehmen Verbosity auf 15 Alle Meter disablen und nur den Hausstromzähler enablen.
Zwei 500W Strahler leuchten lassen.
Das ganze 10-15min laufen lassen.
Und sich dann die vzlogger.log und das dump file anschauen?
Kommt man damit weiter?

Lieben Gruß,
Chris

-----Ursprüngliche Nachricht-----
Von: Frank Richter [mailto:frank.richter83 at gmail.com]
Gesendet: Sonntag, 19. Februar 2017 19:14
An: volkszaehler.org
Betreff: Re: [vz-dev] vzlogger.log läuft voll

Am 19. Februar 2017 um 15:39 schrieb Christian Wulff <christianwulff at gmx.de>:
>
> Der Fehler kommt nun wieder alle 60 Sekunden:

Hast du mal nachgerechnet??? Deine Aussage stimmt nicht mal näherungsweise.

Nimm mal bitte aggtime, aggmode und aggfixedinterval komplett raus aus deiner Config, um auszuschließen dass das Verhalten dadurch beeinflusst wird. So wie es gerade dasteht ist es eh keine sinnvolle Kombination.

Grüße
Frank






More information about the volkszaehler-dev mailing list