btmon for python 3?

[vespaman]

So my config;

Code: Select all

[source]
device_type = gem
reverse_polarity = true
ip_read = true
ip_host = 10.1.200.11
ip_port = 8000
ip_mode = client
ip_poll_interval = 12
[mqtt]
mqtt_out = true
mqtt_upload_period = 12
mqtt_host = localhost
mqtt_clientid = btmon-gem2

I have my broker on the same box as the btmon is running from. I start btmon3 this way;
# /usr/bin/python /etc/btmon/btmon3.py -c /etc/btmon/gem2.cfg

The strange thing is that the error messages now only comes occasionally - it can be totally silent for a couple of minutes before it comes. And there's no connection on the broker. (using mqtt explorer to investigate).


So all in all a receent session;

Code: Select all

 # /usr/bin/python /etc/btmon/btmon3.py -c /etc/btmon/gem2.cfg
2021/01/09 18:07:03 btmon: 3.3.1
2021/01/09 18:07:03 python: 3.8.7 (default, Dec 25 2020, 16:06:21) 
[GCC 10.2.0]
2021/01/09 18:07:03 platform: linux
2021/01/09 18:07:03 polarity is reversed
2021/01/09 18:07:03 device type: gem
2021/01/09 18:07:03 device list: ['']
2021/01/09 18:07:03 packet format: gem48ptbin
2021/01/09 18:07:03 schema: counters
2021/01/09 18:07:03 SOCKET: timeout: 60
2021/01/09 18:07:03 SOCKET: server host: 10.1.200.11
2021/01/09 18:07:03 SOCKET: server port: 8000
2021/01/09 18:07:03 SOCKET: poll interval: 12
2021/01/09 18:07:03 MQTT: mqtt:localhost:1883?clientid=btmon-gem2
2021/01/09 18:07:03 MQTT: user: <not-specified>
2021/01/09 18:07:03 MQTT: tls: <not-specified>
2021/01/09 18:07:03 MQTT: topic: /house/energy
2021/01/09 18:07:03 MQTT: qos: 0
2021/01/09 18:07:03 MQTT: retain: False
2021/01/09 18:07:03 MQTT: will: <not-specified>
2021/01/09 18:07:03 MQTT: upload period: 12
2021/01/09 18:07:03 MQTT: map: 
2021/01/09 18:10:52 can only concatenate str (not "bytes") to str
2021/01/09 18:10:52 3 requests failed for device 
2021/01/09 18:11:07 can only concatenate str (not "bytes") to str
2021/01/09 18:11:07 3 requests failed for device 

[ben]

Attached a new copy on the frontpage of the posts, give it a try.

[vespaman]

I get about the same result with the new version;

2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 3 requests failed for device

.. and nothing happening on the broker.

[ben]

I get about the same result with the new version;

2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 a bytes-like object is required, not 'str'
2021/01/14 09:36:49 3 requests failed for device

.. and nothing happening on the broker.

Going to have to set up a GEM for TCP Client testing it looks like, here's the settings I used below.

Code: Select all

[source]
device_type = gem
reverse_polarity = true
ip_read = true
ip_host = 192.168.2.22
ip_port = 8088
ip_mode = server
[mqtt]
mqtt_out = true
mqtt_upload_period = 12
mqtt_host = localhost
mqtt_clientid = btmon-gem2

[ben]

Turns out it was an easy fix. I forgot to mention if you run the script with "--debug" as an option it'll tell you the line number that's faulting.

Updated the zip on the first page again.

[vespaman]

Nice, now it is working!

There's some errors occurring

Code: Select all

2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 3 requests failed for device 
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 3 requests failed for device 
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 3 requests failed for device 
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 3 requests failed for device 
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 3 requests failed for device 
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 3 requests failed for device 
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 3 requests failed for device 

But maybe they where also around in the old btmon, just that I have never checked the output.

Anyway, a few missed data every now and then isn't the end of the world.

Thank you for fixing!

[ben]

Nice, now it is working!

There's some errors occurring

Code: Select all

2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:44:11 3 requests failed for device 
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 expected START_HEADER0 0xfe, got nothing
2021/01/16 20:58:53 3 requests failed for device 
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:18:34 3 requests failed for device 
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:30:01 3 requests failed for device 
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 expected START_HEADER0 0xfe, got nothing
2021/01/16 21:58:24 3 requests failed for device 
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 expected START_HEADER0 0xfe, got nothing
2021/01/16 22:44:56 3 requests failed for device 
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 expected START_HEADER0 0xfe, got nothing
2021/01/16 23:24:20 3 requests failed for device 

But maybe they where also around in the old btmon, just that I have never checked the output.

Anyway, a few missed data every now and then isn't the end of the world.

Thank you for fixing!

Try running it with --debug to make sure it isn't something crashing.

[vespaman]

So I have been running the new btmon for some time now, and can conclude that there is another issue; results of zero W will not be put to the broker. Infact, I think they may disappear during parsing of packet from GEM (but this is just a guess, --debug does not give any information, apart from the fact the inputs with 0W will be excluded in the MQTT push).

So if i e.g. put the owen on, I get reports of it. But if I switch it off, the last report will never be 0W, but something between 0 and what the run-consumption was. Then, it will stay on that value forever in my logging program. (or until I switch owen on again).

[ben]

So I have been running the new btmon for some time now, and can conclude that there is another issue; results of zero W will not be put to the broker. Infact, I think they may disappear during parsing of packet from GEM (but this is just a guess, --debug does not give any information, apart from the fact the inputs with 0W will be excluded in the MQTT push).

So if i e.g. put the owen on, I get reports of it. But if I switch it off, the last report will never be 0W, but something between 0 and what the run-consumption was. Then, it will stay on that value forever in my logging program. (or until I switch owen on again).

Can you attach a debug log? --debug should show the JSON packet being sent.

[vespaman]

So here's one from yesterday;

Code: Select all

oxygen /etc/btmon # /usr/bin/python /etc/btmon/btmon3.py --debug -c /etc/btmon/gem.cfg
2021/02/16 18:48:58 btmon: 3.3.1
2021/02/16 18:48:58 python: 3.8.7 (default, Feb 14 2021, 12:14:26) 
[GCC 10.2.0]
2021/02/16 18:48:58 platform: linux
2021/02/16 18:48:58 polarity is reversed
2021/02/16 18:48:58 device type: gem
2021/02/16 18:48:58 device list: ['']
2021/02/16 18:48:58 packet format: gem48ptbin
2021/02/16 18:48:58 schema: counters
2021/02/16 18:48:58 buffer size: 120
2021/02/16 18:48:58 SOCKET: timeout: 60
2021/02/16 18:48:58 SOCKET: server host: 10.1.200.7
2021/02/16 18:48:58 SOCKET: server port: 8000
2021/02/16 18:48:58 SOCKET: poll interval: 12
2021/02/16 18:48:58 MQTT: mqtt:localhost:1883?clientid=btmon-gem1
2021/02/16 18:48:58 MQTT: user: <not-specified>
2021/02/16 18:48:58 MQTT: tls: <not-specified>
2021/02/16 18:48:58 MQTT: topic: /house/energy
2021/02/16 18:48:58 MQTT: qos: 0
2021/02/16 18:48:58 MQTT: retain: False
2021/02/16 18:48:58 MQTT: will: <not-specified>
2021/02/16 18:48:58 MQTT: upload period: 12
2021/02/16 18:48:58 MQTT: map: 
2021/02/16 18:48:58 packet format is GEM48PTBinaryPacket
2021/02/16 18:48:58 using collector PollingSocketClientCollector
2021/02/16 18:48:58 using 1 processors:
2021/02/16 18:48:58   MQTTProcessor
2021/02/16 18:48:58 setup PollingSocketClientCollector
2021/02/16 18:48:58 setup MQTTProcessor
2021/02/16 18:48:58 SOCKET: waiting for 12 seconds
2021/02/16 18:49:10 opening socket connection to 10.1.200.7:8000
2021/02/16 18:49:10 sending request 1 to device 
2021/02/16 18:49:10 SOCKET: sending ^^^APISPK
2021/02/16 18:49:10 waiting for data from device 
2021/02/16 18:49:10 reading 1 of 1 packets
2021/02/16 18:49:11 adding buffer for 01000590
2021/02/16 18:49:11 buffering packet ts:1613497751 sn:01000590
2021/02/16 18:49:11 closing socket connection
2021/02/16 18:49:11 buffer info:
2021/02/16 18:49:11   01000590:   1 of 120 (1613497751)
2021/02/16 18:49:11 processing with MQTTProcessor
2021/02/16 18:49:11 not enough data for 01000590
2021/02/16 18:49:11 SOCKET: waiting for 12 seconds
2021/02/16 18:49:23 opening socket connection to 10.1.200.7:8000
2021/02/16 18:49:23 sending request 1 to device 
2021/02/16 18:49:23 SOCKET: sending ^^^APISPK
2021/02/16 18:49:23 waiting for data from device 
2021/02/16 18:49:23 reading 1 of 1 packets
2021/02/16 18:49:24 buffering packet ts:1613497764 sn:01000590
2021/02/16 18:49:24 closing socket connection
2021/02/16 18:49:24 buffer info:
2021/02/16 18:49:24   01000590:   2 of 120 (1613497764)
2021/02/16 18:49:24 processing with MQTTProcessor
2021/02/16 18:49:24 2 buffered packets sn:01000590
2021/02/16 18:49:24 1 calculated packets sn:01000590
2021/02/16 18:49:24 MQTT: len=71, msgs=[{"topic": "/house/energy/01000590_volts", "payload": 229.7, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_w", "payload": 1158.231, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_w", "payload": 1795.154, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_w", "payload": 1014.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_w", "payload": 36.846, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_w", "payload": 334.769, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_w", "payload": 140.462, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_w", "payload": 47.846, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_w", "payload": 677.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_w", "payload": 9.846, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_w", "payload": 964.692, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_w", "payload": 3.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_w", "payload": 103.231, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_w", "payload": 18.385, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_w", "payload": 5.231, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_w", "payload": 653.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_w", "payload": 856.385, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_wh", "payload": 38983126.423, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_wh", "payload": 31072067.837, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_wh", "payload": 21508010.634, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch4_wh", "payload": 1925791.604, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch5_wh", "payload": 226521.929, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch6_wh", "payload": 291194.419, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_wh", "payload": 2473731.378, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch8_wh", "payload": 662055.362, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch9_wh", "payload": -553841.193, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch10_wh", "payload": 49790.834, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_wh", "payload": 11514842.331, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_wh", "payload": 5352073.974, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch13_wh", "payload": 30558.8, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_wh", "payload": 686052.571, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch15_wh", "payload": 254221.222, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_wh", "payload": 12855166.452, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_wh", "payload": 3272632.427, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_wh", "payload": 8470985.594, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch19_wh", "payload": 1927639.411, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch20_wh", "payload": 1101227.07, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch21_wh", "payload": -20762611.861, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch22_wh", "payload": -11737495.056, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_wh", "payload": 1429365.192, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_wh", "payload": 2288746.424, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_wh", "payload": 865967.183, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch26_wh", "payload": 70474.791, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch27_wh", "payload": 440734.911, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_wh", "payload": 252866.122, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch29_wh", "payload": 477896.755, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_wh", "payload": 14014785.535, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_wh", "payload": 21144033.253, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch32_wh", "payload": 642502.049, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_p4", "payload": 29, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t1", "payload": 26.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t2", "payload": 22.5, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t3", "payload": -2.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t4", "payload": 21.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_dwh", "payload": 4.182, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_dwh", "payload": 6.482, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_dwh", "payload": 3.662, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_dwh", "payload": 0.133, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_dwh", "payload": 1.209, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_dwh", "payload": 0.507, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_dwh", "payload": 0.173, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_dwh", "payload": 2.445, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_dwh", "payload": 0.036, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_dwh", "payload": 3.484, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch22_dwh", "payload": 0.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_dwh", "payload": 0.011, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_dwh", "payload": 0.373, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_dwh", "payload": 0.066, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_dwh", "payload": 0.019, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_dwh", "payload": 2.358, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_dwh", "payload": 3.093, "qos": 0, "retain": false}]
2021/02/16 18:49:24 SOCKET: waiting for 12 seconds
2021/02/16 18:49:36 opening socket connection to 10.1.200.7:8000
2021/02/16 18:49:36 sending request 1 to device 
2021/02/16 18:49:36 SOCKET: sending ^^^APISPK
2021/02/16 18:49:36 waiting for data from device 
2021/02/16 18:49:36 reading 1 of 1 packets
2021/02/16 18:49:37 buffering packet ts:1613497777 sn:01000590
2021/02/16 18:49:37 closing socket connection
2021/02/16 18:49:37 buffer info:
2021/02/16 18:49:37   01000590:   3 of 120 (1613497777)
2021/02/16 18:49:37 processing with MQTTProcessor
2021/02/16 18:49:37 2 buffered packets sn:01000590
2021/02/16 18:49:37 1 calculated packets sn:01000590
2021/02/16 18:49:37 MQTT: len=71, msgs=[{"topic": "/house/energy/01000590_volts", "payload": 230.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_w", "payload": 1160.308, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_w", "payload": 1793.692, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_w", "payload": 1014.231, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_w", "payload": 36.769, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_w", "payload": 334.769, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_w", "payload": 140.846, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_w", "payload": 48.538, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_w", "payload": 679.462, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_w", "payload": 9.923, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_w", "payload": 961.231, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_w", "payload": 3.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_w", "payload": 102.769, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_w", "payload": 18.077, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_w", "payload": 5.154, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_w", "payload": 654.308, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_w", "payload": 855.615, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_wh", "payload": 38983130.613, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_wh", "payload": 31072074.314, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_wh", "payload": 21508014.297, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch4_wh", "payload": 1925791.604, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch5_wh", "payload": 226521.929, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch6_wh", "payload": 291194.419, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_wh", "payload": 2473731.511, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch8_wh", "payload": 662055.362, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch9_wh", "payload": -553841.193, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch10_wh", "payload": 49790.834, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_wh", "payload": 11514843.54, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_wh", "payload": 5352074.482, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch13_wh", "payload": 30558.8, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_wh", "payload": 686052.746, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch15_wh", "payload": 254221.222, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_wh", "payload": 12855168.906, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_wh", "payload": 3272632.462, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_wh", "payload": 8470989.065, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch19_wh", "payload": 1927639.411, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch20_wh", "payload": 1101227.07, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch21_wh", "payload": -20762611.861, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch22_wh", "payload": -11737495.056, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_wh", "payload": 1429365.203, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_wh", "payload": 2288746.796, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_wh", "payload": 865967.249, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch26_wh", "payload": 70474.791, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch27_wh", "payload": 440734.911, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_wh", "payload": 252866.14, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch29_wh", "payload": 477896.755, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_wh", "payload": 14014787.898, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_wh", "payload": 21144036.343, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch32_wh", "payload": 642502.049, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_p4", "payload": 29, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t1", "payload": 26.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t2", "payload": 22.5, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t3", "payload": -2.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_t4", "payload": 21.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch1_dwh", "payload": 4.19, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch2_dwh", "payload": 6.477, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch3_dwh", "payload": 3.663, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch7_dwh", "payload": 0.133, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch11_dwh", "payload": 1.209, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch12_dwh", "payload": 0.509, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch14_dwh", "payload": 0.175, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch16_dwh", "payload": 2.454, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch17_dwh", "payload": 0.036, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch18_dwh", "payload": 3.471, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch22_dwh", "payload": 0.0, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch23_dwh", "payload": 0.011, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch24_dwh", "payload": 0.371, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch25_dwh", "payload": 0.065, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch28_dwh", "payload": 0.019, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch30_dwh", "payload": 2.363, "qos": 0, "retain": false}, {"topic": "/house/energy/01000590_ch31_dwh", "payload": 3.09, "qos": 0, "retain": false}]
2021/02/16 18:49:37 SOCKET: waiting for 12 seconds
2021/02/16 18:49:50 opening socket connection to 10.1.200.7:8000
2021/02/16 18:49:50 sending request 1 to device 
2021/02/16 18:49:50 SOCKET: sending ^^^APISPK
2021/02/16 18:49:50 waiting for data from device 
2021/02/16 18:49:50 reading 1 of 1 packets
2021/02/16 18:49:50 buffering packet ts:1613497790 sn:01000590
2021/02/16 18:49:50 closing socket connection
2021/02/16 18:49:50 buffer info:
2021/02/16 18:49:50   01000590:   4 of 120 (1613497790)
2021/02/16 18:49:50 processing with MQTTProcessor
2021/02/16 18:49:50 2 buffered packets sn:01000590
2021/02/16 18:49:50 1 calculated packets sn:01000590

Thanks,
- Micael