TCP interfacer not running?

It appears The TCP interfacer is not running since I ca not get mode 12 inputs to show up? Anyone knows hos to enable it?

I have installed latest emonSD image. Also tried The The 2017 image but same issue.

You need to give us way more information.

  1. What is the hardware (sending and receiving).
  2. how have you set it up (it won’t just work).

I have emonpi and Fronius inverter (and smart meter) on local network.

Modbus setup in inverter, TCP, 502 with floating point

Even if I don’t get any data from Fronius inverter should not node 12 show up in list with zero values if I “enable it” in emonhub with correct IP? Or does that not happen until valid data is transmitted?

What instructions did you follow to setup emonhub?

Can you post your emonhub configuration please.

Also, restart the emonhub from the web UI and then post the initial portion of the log from restart.

When posting code please use 3 backticks (top left of keyboard) on a line before the pasted text/code and 3 more on a line after.

```
code
```

I think I found the problem as per the emonhub log (PYMODBUS not started), how do I go about automativally starting it?

Is there another configuration file for this or a start command?


Emonhub log:

2020-06-30 16:02:49,129 INFO MainThread EmonHub emonHub emon-pi variant v3-beta

2020-06-30 16:02:49,130 INFO MainThread Opening hub...

2020-06-30 16:02:49,131 INFO MainThread Logging level set to DEBUG

2020-06-30 16:02:49,132 INFO MainThread Creating EmonHubJeeInterfacer 'RFM2Pi'

2020-06-30 16:02:49,135 DEBUG MainThread Opening serial port: /dev/ttyAMA0 @ 38400 bits/s

2020-06-30 16:02:51,146 INFO MainThread RFM2Pi device firmware version: OK

2020-06-30 16:02:51,147 INFO MainThread RFM2Pi device current settings: 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 16:02:51,148 INFO MainThread Setting RFM2Pi baseid: 5 (5i)

2020-06-30 16:02:52,150 INFO MainThread Setting RFM2Pi frequency: 433 (4b)

2020-06-30 16:02:53,152 INFO MainThread Setting RFM2Pi group: 210 (210g)

2020-06-30 16:02:54,155 INFO MainThread Setting RFM2Pi quiet: 1 (1q)

2020-06-30 16:02:55,157 INFO MainThread Setting RFM2Pi calibration: 230V (1p)

2020-06-30 16:02:56,159 DEBUG MainThread Setting RFM2Pi pubchannels: ['ToEmonCMS']

2020-06-30 16:02:56,160 DEBUG MainThread Setting RFM2Pi subchannels: ['ToRFM12']

2020-06-30 16:02:56,162 INFO MainThread Creating EmonHubMqttInterfacer 'MQTT'

2020-06-30 16:02:56,167 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 16:02:56,169 DEBUG MainThread Setting MQTT pubchannels: ['ToRFM12']

2020-06-30 16:02:56,170 DEBUG MainThread Setting MQTT subchannels: ['ToEmonCMS']

2020-06-30 16:02:56,171 INFO MainThread Setting MQTT node_format_enable: 1

2020-06-30 16:02:56,171 INFO MainThread Setting MQTT nodevar_format_enable: 1

2020-06-30 16:02:56,172 INFO MainThread Setting MQTT nodevar_format_basetopic: emon/

2020-06-30 16:02:56,173 INFO MainThread Creating EmonHubEmoncmsHTTPInterfacer 'emoncmsorg'

2020-06-30 16:02:56,175 DEBUG MainThread Setting emoncmsorg pubchannels: ['ToRFM12']

2020-06-30 16:02:56,175 DEBUG MainThread Setting emoncmsorg subchannels: ['ToEmonCMS']

2020-06-30 16:02:56,176 WARNING MainThread Setting emoncmsorg apikey: obscured

2020-06-30 16:02:56,177 INFO MainThread Setting emoncmsorg url: https://emoncms.org

2020-06-30 16:02:56,177 INFO MainThread Setting emoncmsorg senddata: 1

2020-06-30 16:02:56,178 INFO MainThread Setting emoncmsorg sendstatus: 1

2020-06-30 16:02:56,179 INFO MainThread Creating EmonModbusTcpInterfacer 'ModbusTCP'

2020-06-30 16:02:56,180 ERROR MainThread PYMODBUS NOT PRESENT BUT NEEDED !!

2020-06-30 16:02:56,182 DEBUG MainThread Setting ModbusTCP rName: ['Inverter_status', 'AC_power_watts', 'AC_LifetimekWh', 'DayWh', 'mppt1', 'mppt2', 'Vmppt1', 'Vmppt2', 'PhVphA', 'PhVphB', 'PhVphC']

2020-06-30 16:02:56,182 DEBUG MainThread Setting ModbusTCP register: ['40118', '40092', '40102', '502', '40285', '40305', '40284', '40304', '40086', '40088', '40090']

2020-06-30 16:02:56,183 DEBUG MainThread Setting ModbusTCP nReg: ['1', '2', '2', '4', '1', '1', '1', '1', '2', '2', '2']

2020-06-30 16:02:56,183 DEBUG MainThread Setting ModbusTCP rType: ['uint16', 'float32', 'float32', 'uint64', 'uint16', 'uint16', 'uint16', 'uint16', 'float32', 'float32', 'float32']

2020-06-30 16:02:56,184 DEBUG MainThread Setting ModbusTCP nodeId: 12

2020-06-30 16:02:56,184 DEBUG MainThread Setting ModbusTCP pubchannels: ToRFM12

2020-06-30 16:02:56,185 DEBUG MainThread Setting ModbusTCP interval: 1

2020-06-30 16:02:56,271 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 16:02:56,376 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 16:02:56,479 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 16:02:56,586 DEBUG RFM2Pi 1 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 16:02:56,588 DEBUG RFM2Pi 1 Timestamp : 1593525776.585697

2020-06-30 16:02:56,589 DEBUG RFM2Pi 1 From Node : 5

2020-06-30 16:02:56,590 DEBUG RFM2Pi 1 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 16:02:56,590 DEBUG RFM2Pi 1 Sent to channel(start)' : ToEmonCMS

2020-06-30 16:02:56,591 DEBUG RFM2Pi 1 Sent to channel(end)' : ToEmonCMS

2020-06-30 16:02:56,675 INFO MQTT Connecting to MQTT Server

2020-06-30 16:02:56,694 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 16:02:56,779 INFO MQTT connection status: Connection successful

2020-06-30 16:02:56,780 DEBUG MQTT CONACK => Return code: 0

2020-06-30 16:02:56,781 DEBUG emoncmsorg Buffer size: 1

2020-06-30 16:02:56,883 INFO MQTT on_subscribe

2020-06-30 16:02:57,707 DEBUG RFM2Pi 2 NEW FRAME : OK 8 198 9 13 254 0 0 0 0 155 101 211 0 184 11 184 11 184 11 184 11 184 11 0 0 0 0 (-69)

2020-06-30 16:02:57,710 DEBUG RFM2Pi 2 Timestamp : 1593525777.7069516

2020-06-30 16:02:57,711 DEBUG RFM2Pi 2 From Node : 8

2020-06-30 16:02:57,711 DEBUG RFM2Pi 2 Values : [8506.8, -499, 0, 0, 260.11, 21.1, 300, 300, 300, 300, 300, 0]

2020-06-30 16:02:57,712 DEBUG RFM2Pi 2 RSSI : -69

2020-06-30 16:02:57,713 DEBUG RFM2Pi 2 Sent to channel(start)' : ToEmonCMS

2020-06-30 16:02:57,713 DEBUG RFM2Pi 2 Sent to channel(end)' : ToEmonCMS

2020-06-30 16:02:57,890 DEBUG MQTT Publishing: emon/emontx3/power1 8506.8

2020-06-30 16:02:57,891 DEBUG MQTT Publishing: emon/emontx3/power2 -499

2020-06-30 16:02:57,892 DEBUG MQTT Publishing: emon/emontx3/power3 0

2020-06-30 16:02:57,894 DEBUG MQTT Publishing: emon/emontx3/power4 0

2020-06-30 16:02:57,895 DEBUG MQTT Publishing: emon/emontx3/vrms 260.11

2020-06-30 16:02:57,897 DEBUG MQTT Publishing: emon/emontx3/temp1 21.1

2020-06-30 16:02:57,898 DEBUG MQTT Publishing: emon/emontx3/temp2 300

2020-06-30 16:02:57,899 DEBUG MQTT Publishing: emon/emontx3/temp3 300

2020-06-30 16:02:57,901 DEBUG MQTT Publishing: emon/emontx3/temp4 300

2020-06-30 16:02:57,902 DEBUG MQTT Publishing: emon/emontx3/temp5 300

2020-06-30 16:02:57,903 DEBUG MQTT Publishing: emon/emontx3/temp6 300

2020-06-30 16:02:57,904 DEBUG MQTT Publishing: emon/emontx3/pulse 0

2020-06-30 16:02:57,906 DEBUG MQTT Publishing: emon/emontx3/rssi -69

2020-06-30 16:02:57,907 INFO MQTT Publishing: emonhub/rx/8/values 8506.8,-499,0,0,260.11,21.1,300,300,300,300,300,0,-69


Config:

[[ModbusTCP]]

# this interfacer retrieves register information from modbusTCP clients

# retrieve register information from modbus TCP documentation for your inverter.

# Information here is designed for Fronius Symo 3 phase inverter.

Type = EmonModbusTcpInterfacer

[[[init_settings]]]

modbus_IP = 192.168.1.192 # ip address of client to retrieve data from

modbus_port = 502 # Portclient listens on

[[[runtimesettings]]]

# list of names of items being retrieved

# This example retrieves the Inverter status, AC power in watts being produced, AC Lifetime KWh produced,

# KWh produced for current day,

rName = Inverter_status,AC_power_watts,AC_LifetimekWh,DayWh,mppt1,mppt2,Vmppt1,Vmppt2,PhVphA,PhVphB,PhVphC

# List of starting registers for items listed above

register = 40118,40092,40102,502,40285,40305,40284,40304,40086,40088,40090

# List of # of registers used for each item

nReg = 1,2,2,4,1,1,1,1,2,2,2

# Data type for each item above

rType = uint16,float32,float32,uint64,uint16,uint16,uint16,uint16,float32,float32,float32

# nodeid used to match with node definition in nodes section below. Can be set to any integer value not previously used.

nodeId = 12

# Channel to publish data to should leave as ToEmonCMS

pubchannels = ToRFM12

# time in seconds between checks, This is in addition to emonhub_interfacer.run() sleep time of .01

# use this value to set the frequency of data retrieval from modbus client

interval = 1

[[12]]

nodename = fronius

[[[rx]]]

names = Inverter_status,AC_power_watts,AC_LifetimekWh,DayWh,mppt1,mppt2,Vmppt1,Vmppt2,PhVphA,PhVphB,PhVphC

datacodes = H,f,f,Q,H,H,H,H,f,f,f

scales = 1,0.1,0.1,1,1,1,1,1,0.1,0.1,0.1

units = V,W,kWh,Wh,W,W,V,V,V,V,V

Ah, pymodbus is not installed by the installer.

sudo apt-get install python3-pymodbus

Now it seems to communicate OK but still no node 12 (or Fronius). What else is wrong you think?


020-06-30 17:09:56,463 INFO MainThread EmonHub emonHub emon-pi variant v3-beta

2020-06-30 17:09:56,464 INFO MainThread Opening hub...

2020-06-30 17:09:56,465 INFO MainThread Logging level set to DEBUG

2020-06-30 17:09:56,466 INFO MainThread Creating EmonHubJeeInterfacer 'RFM2Pi'

2020-06-30 17:09:56,469 DEBUG MainThread Opening serial port: /dev/ttyAMA0 @ 38400 bits/s

2020-06-30 17:09:58,476 INFO MainThread RFM2Pi device firmware version & configuration: not available

2020-06-30 17:09:58,477 INFO MainThread Setting RFM2Pi baseid: 5 (5i)

2020-06-30 17:09:59,479 INFO MainThread Setting RFM2Pi frequency: 433 (4b)

2020-06-30 17:10:00,481 INFO MainThread Setting RFM2Pi group: 210 (210g)

2020-06-30 17:10:01,483 INFO MainThread Setting RFM2Pi quiet: 1 (1q)

2020-06-30 17:10:02,486 INFO MainThread Setting RFM2Pi calibration: 230V (1p)

2020-06-30 17:10:03,488 DEBUG MainThread Setting RFM2Pi pubchannels: ['ToEmonCMS']

2020-06-30 17:10:03,489 DEBUG MainThread Setting RFM2Pi subchannels: ['ToRFM12']

2020-06-30 17:10:03,491 INFO MainThread Creating EmonHubMqttInterfacer 'MQTT'

2020-06-30 17:10:03,496 DEBUG MainThread Setting MQTT pubchannels: ['ToRFM12']

2020-06-30 17:10:03,497 DEBUG MainThread Setting MQTT subchannels: ['ToEmonCMS']

2020-06-30 17:10:03,498 INFO MainThread Setting MQTT node_format_enable: 1

2020-06-30 17:10:03,498 INFO MainThread Setting MQTT nodevar_format_enable: 1

2020-06-30 17:10:03,499 INFO MainThread Setting MQTT nodevar_format_basetopic: emon/

2020-06-30 17:10:03,503 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:10:03,504 INFO MainThread Creating EmonHubEmoncmsHTTPInterfacer 'emoncmsorg'

2020-06-30 17:10:03,506 DEBUG MainThread Setting emoncmsorg pubchannels: ['ToRFM12']

2020-06-30 17:10:03,506 DEBUG MainThread Setting emoncmsorg subchannels: ['ToEmonCMS']

2020-06-30 17:10:03,507 WARNING MainThread Setting emoncmsorg apikey: obscured

2020-06-30 17:10:03,507 INFO MainThread Setting emoncmsorg url: https://emoncms.org

2020-06-30 17:10:03,508 INFO MainThread Setting emoncmsorg senddata: 1

2020-06-30 17:10:03,508 INFO MainThread Setting emoncmsorg sendstatus: 1

2020-06-30 17:10:03,510 INFO MainThread Creating EmonModbusTcpInterfacer 'ModbusTCP'

2020-06-30 17:10:03,511 INFO MainThread pymodbus installed

2020-06-30 17:10:03,512 DEBUG MainThread EmonModbusTcpInterfacer args: 192.168.1.192 - 502

2020-06-30 17:10:03,515 INFO MainThread Opening modbusTCP connection: 502 @ 192.168.1.192

2020-06-30 17:10:03,516 INFO MainThread Modbustcp client Connected

2020-06-30 17:10:03,518 DEBUG MainThread Setting ModbusTCP rName: ['Inverter_status', 'AC_power_watts', 'AC_LifetimekWh', 'DayWh', 'mppt1', 'mppt2', 'Vmppt1', 'Vmppt2', 'PhVphA', 'PhVphB', 'PhVphC']

2020-06-30 17:10:03,518 DEBUG MainThread Setting ModbusTCP register: ['40118', '40092', '40102', '502', '40285', '40305', '40284', '40304', '40086', '40088', '40090']

2020-06-30 17:10:03,519 DEBUG MainThread Setting ModbusTCP nReg: ['1', '2', '2', '4', '1', '1', '1', '1', '2', '2', '2']

2020-06-30 17:10:03,519 DEBUG MainThread Setting ModbusTCP rType: ['uint16', 'float32', 'float32', 'uint64', 'uint16', 'uint16', 'uint16', 'uint16', 'float32', 'float32', 'float32']

2020-06-30 17:10:03,520 DEBUG MainThread Setting ModbusTCP nodeId: 12

2020-06-30 17:10:03,521 DEBUG MainThread Setting ModbusTCP pubchannels: ToRFM12

2020-06-30 17:10:03,521 DEBUG MainThread Setting ModbusTCP interval: 1

2020-06-30 17:10:03,612 DEBUG RFM2Pi 1 NEW FRAME : OK 8 38 12 157 253 0 0 0 0 168 99 211 0 184 11 184 11 184 11 184 11 184 11 0 0 0 0 (-63)

2020-06-30 17:10:03,616 DEBUG RFM2Pi 1 Timestamp : 1593529803.6122196

2020-06-30 17:10:03,616 DEBUG RFM2Pi 1 From Node : 8

2020-06-30 17:10:03,617 DEBUG RFM2Pi 1 Values : [10574, -611, 0, 0, 255.12, 21.1, 300, 300, 300, 300, 300, 0]

2020-06-30 17:10:03,618 DEBUG RFM2Pi 1 RSSI : -63

2020-06-30 17:10:03,618 DEBUG RFM2Pi 1 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:03,619 DEBUG RFM2Pi 1 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:03,722 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:10:03,803 INFO MQTT Connecting to MQTT Server

2020-06-30 17:10:03,827 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:10:03,906 INFO MQTT connection status: Connection successful

2020-06-30 17:10:03,907 DEBUG MQTT CONACK => Return code: 0

2020-06-30 17:10:03,911 DEBUG emoncmsorg Buffer size: 1

2020-06-30 17:10:03,933 DEBUG RFM2Pi 2 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:10:03,935 DEBUG RFM2Pi 2 Timestamp : 1593529803.9330533

2020-06-30 17:10:03,936 DEBUG RFM2Pi 2 From Node : 5

2020-06-30 17:10:03,937 DEBUG RFM2Pi 2 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:10:03,937 DEBUG RFM2Pi 2 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:03,938 DEBUG RFM2Pi 2 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:04,009 INFO MQTT on_subscribe

2020-06-30 17:10:04,010 DEBUG MQTT Publishing: emon/emonpi/power1 0

2020-06-30 17:10:04,012 DEBUG MQTT Publishing: emon/emonpi/power2 0

2020-06-30 17:10:04,013 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 0

2020-06-30 17:10:04,015 DEBUG MQTT Publishing: emon/emonpi/vrms 0

2020-06-30 17:10:04,017 DEBUG MQTT Publishing: emon/emonpi/t1 0

2020-06-30 17:10:04,018 DEBUG MQTT Publishing: emon/emonpi/t2 0

2020-06-30 17:10:04,020 DEBUG MQTT Publishing: emon/emonpi/t3 0

2020-06-30 17:10:04,021 DEBUG MQTT Publishing: emon/emonpi/t4 0

2020-06-30 17:10:04,023 DEBUG MQTT Publishing: emon/emonpi/t5 0

2020-06-30 17:10:04,024 DEBUG MQTT Publishing: emon/emonpi/t6 0

2020-06-30 17:10:04,026 DEBUG MQTT Publishing: emon/emonpi/pulsecount 1

2020-06-30 17:10:04,027 INFO MQTT Publishing: emonhub/rx/5/values 0,0,0,0,0,0,0,0,0,0,1

2020-06-30 17:10:04,041 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:10:04,148 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:10:04,259 DEBUG RFM2Pi 3 NEW FRAME : OK 11 127 13 38 3 241 10 0 0 214 102 194 11 194 11 194 11 194 11 194 11 194 11 137 12 24 0 (-58)

2020-06-30 17:10:04,265 DEBUG RFM2Pi 3 Timestamp : 1593529804.2591515

2020-06-30 17:10:04,266 DEBUG RFM2Pi 3 From Node : 11

2020-06-30 17:10:04,267 DEBUG RFM2Pi 3 Values : [3455, 806, 2801, 0, 263.26, 301, 301, 301, 301, 301, 301, 1576073]

2020-06-30 17:10:04,268 DEBUG RFM2Pi 3 RSSI : -58

2020-06-30 17:10:04,268 DEBUG RFM2Pi 3 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:04,269 DEBUG RFM2Pi 3 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:04,439 DEBUG MQTT Publishing: emon/3phase/powerL1 3455

2020-06-30 17:10:04,441 DEBUG MQTT Publishing: emon/3phase/powerL2 806

2020-06-30 17:10:04,442 DEBUG MQTT Publishing: emon/3phase/powerL3 2801

2020-06-30 17:10:04,443 DEBUG MQTT Publishing: emon/3phase/power4 0

2020-06-30 17:10:04,445 DEBUG MQTT Publishing: emon/3phase/Vrms 263.26

2020-06-30 17:10:04,446 DEBUG MQTT Publishing: emon/3phase/temp1 301

2020-06-30 17:10:04,447 DEBUG MQTT Publishing: emon/3phase/temp2 301

2020-06-30 17:10:04,449 DEBUG MQTT Publishing: emon/3phase/temp3 301

2020-06-30 17:10:04,450 DEBUG MQTT Publishing: emon/3phase/temp4 301

2020-06-30 17:10:04,452 DEBUG MQTT Publishing: emon/3phase/temp5 301

2020-06-30 17:10:04,453 DEBUG MQTT Publishing: emon/3phase/temp6 301

2020-06-30 17:10:04,454 DEBUG MQTT Publishing: emon/3phase/pulse 1576073

2020-06-30 17:10:04,455 DEBUG MQTT Publishing: emon/3phase/rssi -58

2020-06-30 17:10:04,457 INFO MQTT Publishing: emonhub/rx/11/values 3455,806,2801,0,263.26,301,301,301,301,301,301,1576073,-58

2020-06-30 17:10:04,531 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:10:04,532 DEBUG ModbusTCP datacode H

2020-06-30 17:10:04,532 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:10:04,739 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:10:04,740 DEBUG ModbusTCP value: 4

2020-06-30 17:10:04,740 DEBUG ModbusTCP datacode f

2020-06-30 17:10:04,741 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:10:04,951 DEBUG ModbusTCP Encoded value: (0, 104, 131, 70)

2020-06-30 17:10:04,952 DEBUG ModbusTCP value: 16820.0

2020-06-30 17:10:04,953 DEBUG ModbusTCP datacode f

2020-06-30 17:10:04,953 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:10:05,165 DEBUG ModbusTCP Encoded value: (188, 70, 68, 76)

2020-06-30 17:10:05,165 DEBUG ModbusTCP value: 51452655.0

2020-06-30 17:10:05,166 DEBUG ModbusTCP datacode Q

2020-06-30 17:10:05,167 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:10:05,378 DEBUG ModbusTCP Encoded value: (227, 39, 0, 0, 0, 0, 0, 0)

2020-06-30 17:10:05,379 DEBUG ModbusTCP value: 10211

2020-06-30 17:10:05,379 DEBUG ModbusTCP datacode H

2020-06-30 17:10:05,380 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:10:05,591 DEBUG ModbusTCP Encoded value: (44, 69)

2020-06-30 17:10:05,592 DEBUG ModbusTCP value: 17708

2020-06-30 17:10:05,592 DEBUG ModbusTCP datacode H

2020-06-30 17:10:05,593 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:10:05,806 DEBUG ModbusTCP Encoded value: (39, 0)

2020-06-30 17:10:05,807 DEBUG ModbusTCP value: 39

2020-06-30 17:10:05,807 DEBUG ModbusTCP datacode H

2020-06-30 17:10:05,808 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:10:05,990 DEBUG RFM2Pi 5 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:10:05,992 DEBUG RFM2Pi 5 Timestamp : 1593529805.990162

2020-06-30 17:10:05,993 DEBUG RFM2Pi 5 From Node : 5

2020-06-30 17:10:05,994 DEBUG RFM2Pi 5 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:10:05,994 DEBUG RFM2Pi 5 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:05,995 DEBUG RFM2Pi 5 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:06,019 DEBUG ModbusTCP Encoded value: (228, 137)

2020-06-30 17:10:06,020 DEBUG ModbusTCP value: 35300

2020-06-30 17:10:06,020 DEBUG ModbusTCP datacode H

2020-06-30 17:10:06,021 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:10:06,119 DEBUG MQTT Publishing: emon/emonpi/power1 0

2020-06-30 17:10:06,121 DEBUG MQTT Publishing: emon/emonpi/power2 0

2020-06-30 17:10:06,124 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 0

2020-06-30 17:10:06,126 DEBUG MQTT Publishing: emon/emonpi/vrms 0

2020-06-30 17:10:06,130 DEBUG MQTT Publishing: emon/emonpi/t1 0

2020-06-30 17:10:06,135 DEBUG MQTT Publishing: emon/emonpi/t2 0

2020-06-30 17:10:06,136 DEBUG MQTT Publishing: emon/emonpi/t3 0

2020-06-30 17:10:06,137 DEBUG MQTT Publishing: emon/emonpi/t4 0

2020-06-30 17:10:06,139 DEBUG MQTT Publishing: emon/emonpi/t5 0

2020-06-30 17:10:06,141 DEBUG MQTT Publishing: emon/emonpi/t6 0

2020-06-30 17:10:06,145 DEBUG MQTT Publishing: emon/emonpi/pulsecount 1

2020-06-30 17:10:06,146 INFO MQTT Publishing: emonhub/rx/5/values 0,0,0,0,0,0,0,0,0,0,1

2020-06-30 17:10:06,234 DEBUG ModbusTCP Encoded value: (152, 153)

2020-06-30 17:10:06,236 DEBUG ModbusTCP value: 39320

2020-06-30 17:10:06,236 DEBUG ModbusTCP datacode f

2020-06-30 17:10:06,237 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

2020-06-30 17:10:06,448 DEBUG ModbusTCP Encoded value: (0, 224, 18, 69)

2020-06-30 17:10:06,449 DEBUG ModbusTCP value: 2350.0

2020-06-30 17:10:06,449 DEBUG ModbusTCP datacode f

2020-06-30 17:10:06,450 DEBUG ModbusTCP reading register # :40088, qty #: 2, unit #: 1

2020-06-30 17:10:06,670 DEBUG ModbusTCP Encoded value: (0, 144, 18, 69)

2020-06-30 17:10:06,673 DEBUG ModbusTCP value: 2345.0

2020-06-30 17:10:06,673 DEBUG ModbusTCP datacode f

2020-06-30 17:10:06,674 DEBUG ModbusTCP reading register # :40090, qty #: 2, unit #: 1

2020-06-30 17:10:06,880 DEBUG ModbusTCP Encoded value: (0, 144, 17, 69)

2020-06-30 17:10:06,881 DEBUG ModbusTCP value: 2328.9999389648438

2020-06-30 17:10:06,882 DEBUG ModbusTCP payload size OK (38)

2020-06-30 17:10:06,882 DEBUG ModbusTCP reporting data: [4, 0, 0, 104, 131, 70, 188, 70, 68, 76, 227, 39, 0, 0, 0, 0, 0, 0, 44, 69, 39, 0, 228, 137, 152, 153, 0, 224, 18, 69, 0, 144, 18, 69, 0, 144, 17, 69]

2020-06-30 17:10:06,883 DEBUG ModbusTCP Return from read data: [4, 0, 0, 104, 131, 70, 188, 70, 68, 76, 227, 39, 0, 0, 0, 0, 0, 0, 44, 69, 39, 0, 228, 137, 152, 153, 0, 224, 18, 69, 0, 144, 18, 69, 0, 144, 17, 69]

2020-06-30 17:10:06,883 DEBUG ModbusTCP 4 NEW FRAME :

2020-06-30 17:10:06,886 DEBUG ModbusTCP 4 Timestamp : 1593529804.5306578

2020-06-30 17:10:06,886 DEBUG ModbusTCP 4 From Node : 12

2020-06-30 17:10:06,887 DEBUG ModbusTCP 4 Values : [4, 1682, 5145265.600000001, 10211, 17708, 39, 35300, 39320, 235, 234.5, 232.9]

2020-06-30 17:10:06,887 DEBUG ModbusTCP 4 Sent to channel(start)' : T

2020-06-30 17:10:06,888 DEBUG ModbusTCP 4 Sent to channel(end)' : T

2020-06-30 17:10:06,889 DEBUG ModbusTCP 4 Sent to channel(start)' : o

2020-06-30 17:10:06,889 DEBUG ModbusTCP 4 Sent to channel(end)' : o

2020-06-30 17:10:06,890 DEBUG ModbusTCP 4 Sent to channel(start)' : R

2020-06-30 17:10:06,890 DEBUG ModbusTCP 4 Sent to channel(end)' : R

2020-06-30 17:10:06,891 DEBUG ModbusTCP 4 Sent to channel(start)' : F

2020-06-30 17:10:06,891 DEBUG ModbusTCP 4 Sent to channel(end)' : F

2020-06-30 17:10:06,892 DEBUG ModbusTCP 4 Sent to channel(start)' : M

2020-06-30 17:10:06,892 DEBUG ModbusTCP 4 Sent to channel(end)' : M

2020-06-30 17:10:06,893 DEBUG ModbusTCP 4 Sent to channel(start)' : 1

2020-06-30 17:10:06,893 DEBUG ModbusTCP 4 Sent to channel(end)' : 1

2020-06-30 17:10:06,894 DEBUG ModbusTCP 4 Sent to channel(start)' : 2

2020-06-30 17:10:06,894 DEBUG ModbusTCP 4 Sent to channel(end)' : 2

2020-06-30 17:10:07,997 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:10:07,998 DEBUG ModbusTCP datacode H

2020-06-30 17:10:07,998 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:10:08,204 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:10:08,205 DEBUG ModbusTCP value: 4

2020-06-30 17:10:08,206 DEBUG ModbusTCP datacode f

2020-06-30 17:10:08,206 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:10:08,418 DEBUG ModbusTCP Encoded value: (0, 228, 132, 70)

2020-06-30 17:10:08,418 DEBUG ModbusTCP value: 17010.0

2020-06-30 17:10:08,419 DEBUG ModbusTCP datacode f

2020-06-30 17:10:08,420 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:10:08,631 DEBUG ModbusTCP Encoded value: (195, 70, 68, 76)

2020-06-30 17:10:08,632 DEBUG ModbusTCP value: 51452685.0

2020-06-30 17:10:08,633 DEBUG ModbusTCP datacode Q

2020-06-30 17:10:08,633 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:10:08,845 DEBUG ModbusTCP Encoded value: (229, 39, 0, 0, 0, 0, 0, 0)

2020-06-30 17:10:08,846 DEBUG ModbusTCP value: 10213

2020-06-30 17:10:08,846 DEBUG ModbusTCP datacode H

2020-06-30 17:10:08,847 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:10:09,058 DEBUG ModbusTCP Encoded value: (225, 63)

2020-06-30 17:10:09,059 DEBUG ModbusTCP value: 16353

2020-06-30 17:10:09,060 DEBUG ModbusTCP datacode H

2020-06-30 17:10:09,061 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:10:09,133 DEBUG RFM2Pi 7 NEW FRAME : OK 8 186 11 155 253 0 0 0 0 215 98 211 0 184 11 184 11 184 11 184 11 184 11 0 0 0 0 (-63)

2020-06-30 17:10:09,136 DEBUG RFM2Pi 7 Timestamp : 1593529809.1327069

2020-06-30 17:10:09,137 DEBUG RFM2Pi 7 From Node : 8

2020-06-30 17:10:09,137 DEBUG RFM2Pi 7 Values : [10206.8, -613, 0, 0, 253.03, 21.1, 300, 300, 300, 300, 300, 0]

2020-06-30 17:10:09,138 DEBUG RFM2Pi 7 RSSI : -63

2020-06-30 17:10:09,139 DEBUG RFM2Pi 7 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:09,140 DEBUG RFM2Pi 7 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:09,184 DEBUG MQTT Publishing: emon/emontx3/power1 10206.8

2020-06-30 17:10:09,185 DEBUG MQTT Publishing: emon/emontx3/power2 -613

2020-06-30 17:10:09,187 DEBUG MQTT Publishing: emon/emontx3/power3 0

2020-06-30 17:10:09,188 DEBUG MQTT Publishing: emon/emontx3/power4 0

2020-06-30 17:10:09,190 DEBUG MQTT Publishing: emon/emontx3/vrms 253.03

2020-06-30 17:10:09,192 DEBUG MQTT Publishing: emon/emontx3/temp1 21.1

2020-06-30 17:10:09,193 DEBUG MQTT Publishing: emon/emontx3/temp2 300

2020-06-30 17:10:09,194 DEBUG MQTT Publishing: emon/emontx3/temp3 300

2020-06-30 17:10:09,196 DEBUG MQTT Publishing: emon/emontx3/temp4 300

2020-06-30 17:10:09,198 DEBUG MQTT Publishing: emon/emontx3/temp5 300

2020-06-30 17:10:09,199 DEBUG MQTT Publishing: emon/emontx3/temp6 300

2020-06-30 17:10:09,201 DEBUG MQTT Publishing: emon/emontx3/pulse 0

2020-06-30 17:10:09,203 DEBUG MQTT Publishing: emon/emontx3/rssi -63

2020-06-30 17:10:09,204 INFO MQTT Publishing: emonhub/rx/8/values 10206.8,-613,0,0,253.03,21.1,300,300,300,300,300,0,-63

2020-06-30 17:10:09,273 DEBUG ModbusTCP Encoded value: (253, 5)

2020-06-30 17:10:09,274 DEBUG ModbusTCP value: 1533

2020-06-30 17:10:09,275 DEBUG ModbusTCP datacode H

2020-06-30 17:10:09,276 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:10:09,486 DEBUG ModbusTCP Encoded value: (228, 137)

2020-06-30 17:10:09,487 DEBUG ModbusTCP value: 35300

2020-06-30 17:10:09,488 DEBUG ModbusTCP datacode H

2020-06-30 17:10:09,488 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:10:09,700 DEBUG ModbusTCP Encoded value: (152, 153)

2020-06-30 17:10:09,701 DEBUG ModbusTCP value: 39320

2020-06-30 17:10:09,701 DEBUG ModbusTCP datacode f

2020-06-30 17:10:09,702 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

2020-06-30 17:10:09,913 DEBUG ModbusTCP Encoded value: (0, 224, 18, 69)

2020-06-30 17:10:09,914 DEBUG ModbusTCP value: 2350.0

2020-06-30 17:10:09,914 DEBUG ModbusTCP datacode f

2020-06-30 17:10:09,915 DEBUG ModbusTCP reading register # :40088, qty #: 2, unit #: 1

2020-06-30 17:10:10,127 DEBUG ModbusTCP Encoded value: (0, 192, 17, 69)

2020-06-30 17:10:10,128 DEBUG ModbusTCP value: 2331.999969482422

2020-06-30 17:10:10,128 DEBUG ModbusTCP datacode f

2020-06-30 17:10:10,129 DEBUG ModbusTCP reading register # :40090, qty #: 2, unit #: 1

2020-06-30 17:10:10,340 DEBUG ModbusTCP Encoded value: (0, 48, 17, 69)

2020-06-30 17:10:10,341 DEBUG ModbusTCP value: 2323.000030517578

2020-06-30 17:10:10,342 DEBUG ModbusTCP payload size OK (38)

2020-06-30 17:10:10,342 DEBUG ModbusTCP reporting data: [4, 0, 0, 228, 132, 70, 195, 70, 68, 76, 229, 39, 0, 0, 0, 0, 0, 0, 225, 63, 253, 5, 228, 137, 152, 153, 0, 224, 18, 69, 0, 192, 17, 69, 0, 48, 17, 69]

2020-06-30 17:10:10,343 DEBUG ModbusTCP Return from read data: [4, 0, 0, 228, 132, 70, 195, 70, 68, 76, 229, 39, 0, 0, 0, 0, 0, 0, 225, 63, 253, 5, 228, 137, 152, 153, 0, 224, 18, 69, 0, 192, 17, 69, 0, 48, 17, 69]

2020-06-30 17:10:10,344 DEBUG ModbusTCP 6 NEW FRAME :

2020-06-30 17:10:10,346 DEBUG ModbusTCP 6 Timestamp : 1593529807.9967382

2020-06-30 17:10:10,347 DEBUG ModbusTCP 6 From Node : 12

2020-06-30 17:10:10,348 DEBUG ModbusTCP 6 Values : [4, 1701, 5145268.4, 10213, 16353, 1533, 35300, 39320, 235, 233.20000000000002, 232.3]

2020-06-30 17:10:10,348 DEBUG ModbusTCP 6 Sent to channel(start)' : T

2020-06-30 17:10:10,349 DEBUG ModbusTCP 6 Sent to channel(end)' : T

2020-06-30 17:10:10,349 DEBUG ModbusTCP 6 Sent to channel(start)' : o

2020-06-30 17:10:10,350 DEBUG ModbusTCP 6 Sent to channel(end)' : o

2020-06-30 17:10:10,351 DEBUG ModbusTCP 6 Sent to channel(start)' : R

2020-06-30 17:10:10,351 DEBUG ModbusTCP 6 Sent to channel(end)' : R

2020-06-30 17:10:10,352 DEBUG ModbusTCP 6 Sent to channel(start)' : F

2020-06-30 17:10:10,352 DEBUG ModbusTCP 6 Sent to channel(end)' : F

2020-06-30 17:10:10,353 DEBUG ModbusTCP 6 Sent to channel(start)' : M

2020-06-30 17:10:10,353 DEBUG ModbusTCP 6 Sent to channel(end)' : M

2020-06-30 17:10:10,354 DEBUG ModbusTCP 6 Sent to channel(start)' : 1

2020-06-30 17:10:10,354 DEBUG ModbusTCP 6 Sent to channel(end)' : 1

2020-06-30 17:10:10,355 DEBUG ModbusTCP 6 Sent to channel(start)' : 2

2020-06-30 17:10:10,356 DEBUG ModbusTCP 6 Sent to channel(end)' : 2

2020-06-30 17:10:11,055 DEBUG RFM2Pi 8 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:10:11,057 DEBUG RFM2Pi 8 Timestamp : 1593529811.054755

2020-06-30 17:10:11,058 DEBUG RFM2Pi 8 From Node : 5

2020-06-30 17:10:11,058 DEBUG RFM2Pi 8 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:10:11,059 DEBUG RFM2Pi 8 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:11,060 DEBUG RFM2Pi 8 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:11,231 DEBUG MQTT Publishing: emon/emonpi/power1 0

2020-06-30 17:10:11,233 DEBUG MQTT Publishing: emon/emonpi/power2 0

2020-06-30 17:10:11,234 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 0

2020-06-30 17:10:11,235 DEBUG MQTT Publishing: emon/emonpi/vrms 0

2020-06-30 17:10:11,237 DEBUG MQTT Publishing: emon/emonpi/t1 0

2020-06-30 17:10:11,238 DEBUG MQTT Publishing: emon/emonpi/t2 0

2020-06-30 17:10:11,239 DEBUG MQTT Publishing: emon/emonpi/t3 0

2020-06-30 17:10:11,241 DEBUG MQTT Publishing: emon/emonpi/t4 0

2020-06-30 17:10:11,242 DEBUG MQTT Publishing: emon/emonpi/t5 0

2020-06-30 17:10:11,243 DEBUG MQTT Publishing: emon/emonpi/t6 0

2020-06-30 17:10:11,244 DEBUG MQTT Publishing: emon/emonpi/pulsecount 1

2020-06-30 17:10:11,246 INFO MQTT Publishing: emonhub/rx/5/values 0,0,0,0,0,0,0,0,0,0,1

2020-06-30 17:10:11,458 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:10:11,459 DEBUG ModbusTCP datacode H

2020-06-30 17:10:11,460 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:10:11,666 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:10:11,667 DEBUG ModbusTCP value: 4

2020-06-30 17:10:11,668 DEBUG ModbusTCP datacode f

2020-06-30 17:10:11,668 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:10:11,880 DEBUG ModbusTCP Encoded value: (0, 204, 131, 70)

2020-06-30 17:10:11,881 DEBUG ModbusTCP value: 16870.0

2020-06-30 17:10:11,881 DEBUG ModbusTCP datacode f

2020-06-30 17:10:11,882 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:10:12,094 DEBUG ModbusTCP Encoded value: (200, 70, 68, 76)

2020-06-30 17:10:12,094 DEBUG ModbusTCP value: 51452705.0

2020-06-30 17:10:12,095 DEBUG ModbusTCP datacode Q

2020-06-30 17:10:12,095 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:10:12,307 DEBUG ModbusTCP Encoded value: (230, 39, 0, 0, 0, 0, 0, 0)

2020-06-30 17:10:12,308 DEBUG ModbusTCP value: 10214

2020-06-30 17:10:12,309 DEBUG ModbusTCP datacode H

2020-06-30 17:10:12,309 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:10:12,520 DEBUG ModbusTCP Encoded value: (182, 65)

2020-06-30 17:10:12,521 DEBUG ModbusTCP value: 16822

2020-06-30 17:10:12,521 DEBUG ModbusTCP datacode H

2020-06-30 17:10:12,522 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:10:12,733 DEBUG ModbusTCP Encoded value: (21, 3)

2020-06-30 17:10:12,734 DEBUG ModbusTCP value: 789

2020-06-30 17:10:12,734 DEBUG ModbusTCP datacode H

2020-06-30 17:10:12,735 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:10:12,946 DEBUG ModbusTCP Encoded value: (162, 138)

2020-06-30 17:10:12,947 DEBUG ModbusTCP value: 35490

2020-06-30 17:10:12,948 DEBUG ModbusTCP datacode H

2020-06-30 17:10:12,948 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:10:13,159 DEBUG ModbusTCP Encoded value: (36, 154)

2020-06-30 17:10:13,160 DEBUG ModbusTCP value: 39460

2020-06-30 17:10:13,161 DEBUG ModbusTCP datacode f

2020-06-30 17:10:13,162 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

2020-06-30 17:10:13,372 DEBUG ModbusTCP Encoded value: (0, 144, 18, 69)

2020-06-30 17:10:13,373 DEBUG ModbusTCP value: 2345.0

2020-06-30 17:10:13,373 DEBUG ModbusTCP datacode f

2020-06-30 17:10:13,374 DEBUG ModbusTCP reading register # :40088, qty #: 2, unit #: 1

2020-06-30 17:10:13,585 DEBUG ModbusTCP Encoded value: (0, 176, 17, 69)

2020-06-30 17:10:13,586 DEBUG ModbusTCP value: 2331.0000610351562

2020-06-30 17:10:13,587 DEBUG ModbusTCP datacode f

2020-06-30 17:10:13,587 DEBUG ModbusTCP reading register # :40090, qty #: 2, unit #: 1

2020-06-30 17:10:13,786 DEBUG RFM2Pi 10 NEW FRAME : OK 11 235 14 232 3 24 13 0 0 13 102 194 11 194 11 194 11 194 11 194 11 194 11 160 12 24 0 (-59)

2020-06-30 17:10:13,789 DEBUG RFM2Pi 10 Timestamp : 1593529813.7865148

2020-06-30 17:10:13,790 DEBUG RFM2Pi 10 From Node : 11

2020-06-30 17:10:13,790 DEBUG RFM2Pi 10 Values : [3819, 1000, 3352, 0, 261.25, 301, 301, 301, 301, 301, 301, 1576096]

2020-06-30 17:10:13,791 DEBUG RFM2Pi 10 RSSI : -59

2020-06-30 17:10:13,791 DEBUG RFM2Pi 10 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:13,792 DEBUG RFM2Pi 10 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:13,799 DEBUG ModbusTCP Encoded value: (0, 48, 17, 69)

2020-06-30 17:10:13,800 DEBUG ModbusTCP value: 2323.000030517578

2020-06-30 17:10:13,800 DEBUG ModbusTCP payload size OK (38)

2020-06-30 17:10:13,801 DEBUG ModbusTCP reporting data: [4, 0, 0, 204, 131, 70, 200, 70, 68, 76, 230, 39, 0, 0, 0, 0, 0, 0, 182, 65, 21, 3, 162, 138, 36, 154, 0, 144, 18, 69, 0, 176, 17, 69, 0, 48, 17, 69]

2020-06-30 17:10:13,801 DEBUG ModbusTCP Return from read data: [4, 0, 0, 204, 131, 70, 200, 70, 68, 76, 230, 39, 0, 0, 0, 0, 0, 0, 182, 65, 21, 3, 162, 138, 36, 154, 0, 144, 18, 69, 0, 176, 17, 69, 0, 48, 17, 69]

2020-06-30 17:10:13,802 DEBUG ModbusTCP 9 NEW FRAME :

2020-06-30 17:10:13,804 DEBUG ModbusTCP 9 Timestamp : 1593529811.4578066

2020-06-30 17:10:13,805 DEBUG ModbusTCP 9 From Node : 12

2020-06-30 17:10:13,805 DEBUG ModbusTCP 9 Values : [4, 1687, 5145270.4, 10214, 16822, 789, 35490, 39460, 234.5, 233.10000000000002, 232.3]

2020-06-30 17:10:13,806 DEBUG ModbusTCP 9 Sent to channel(start)' : T

2020-06-30 17:10:13,806 DEBUG ModbusTCP 9 Sent to channel(end)' : T

2020-06-30 17:10:13,807 DEBUG ModbusTCP 9 Sent to channel(start)' : o

2020-06-30 17:10:13,807 DEBUG ModbusTCP 9 Sent to channel(end)' : o

2020-06-30 17:10:13,808 DEBUG ModbusTCP 9 Sent to channel(start)' : R

2020-06-30 17:10:13,808 DEBUG ModbusTCP 9 Sent to channel(end)' : R

2020-06-30 17:10:13,809 DEBUG ModbusTCP 9 Sent to channel(start)' : F

2020-06-30 17:10:13,810 DEBUG ModbusTCP 9 Sent to channel(end)' : F

2020-06-30 17:10:13,810 DEBUG ModbusTCP 9 Sent to channel(start)' : M

2020-06-30 17:10:13,811 DEBUG ModbusTCP 9 Sent to channel(end)' : M

2020-06-30 17:10:13,811 DEBUG ModbusTCP 9 Sent to channel(start)' : 1

2020-06-30 17:10:13,812 DEBUG ModbusTCP 9 Sent to channel(end)' : 1

2020-06-30 17:10:13,812 DEBUG ModbusTCP 9 Sent to channel(start)' : 2

2020-06-30 17:10:13,813 DEBUG ModbusTCP 9 Sent to channel(end)' : 2

2020-06-30 17:10:13,997 DEBUG MQTT Publishing: emon/3phase/powerL1 3819

2020-06-30 17:10:13,999 DEBUG MQTT Publishing: emon/3phase/powerL2 1000

2020-06-30 17:10:14,001 DEBUG MQTT Publishing: emon/3phase/powerL3 3352

2020-06-30 17:10:14,002 DEBUG MQTT Publishing: emon/3phase/power4 0

2020-06-30 17:10:14,003 DEBUG MQTT Publishing: emon/3phase/Vrms 261.25

2020-06-30 17:10:14,005 DEBUG MQTT Publishing: emon/3phase/temp1 301

2020-06-30 17:10:14,006 DEBUG MQTT Publishing: emon/3phase/temp2 301

2020-06-30 17:10:14,007 DEBUG MQTT Publishing: emon/3phase/temp3 301

2020-06-30 17:10:14,008 DEBUG MQTT Publishing: emon/3phase/temp4 301

2020-06-30 17:10:14,010 DEBUG MQTT Publishing: emon/3phase/temp5 301

2020-06-30 17:10:14,011 DEBUG MQTT Publishing: emon/3phase/temp6 301

2020-06-30 17:10:14,013 DEBUG MQTT Publishing: emon/3phase/pulse 1576096

2020-06-30 17:10:14,014 DEBUG MQTT Publishing: emon/3phase/rssi -59

2020-06-30 17:10:14,015 INFO MQTT Publishing: emonhub/rx/11/values 3819,1000,3352,0,261.25,301,301,301,301,301,301,1576096,-59

2020-06-30 17:10:14,921 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:10:14,921 DEBUG ModbusTCP datacode H

2020-06-30 17:10:14,922 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:10:15,128 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:10:15,129 DEBUG ModbusTCP value: 4

2020-06-30 17:10:15,130 DEBUG ModbusTCP datacode f

2020-06-30 17:10:15,130 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:10:15,341 DEBUG ModbusTCP Encoded value: (0, 32, 128, 70)

2020-06-30 17:10:15,342 DEBUG ModbusTCP value: 16400.0

2020-06-30 17:10:15,342 DEBUG ModbusTCP datacode f

2020-06-30 17:10:15,343 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:10:15,554 DEBUG ModbusTCP Encoded value: (203, 70, 68, 76)

2020-06-30 17:10:15,555 DEBUG ModbusTCP value: 51452715.0

2020-06-30 17:10:15,556 DEBUG ModbusTCP datacode Q

2020-06-30 17:10:15,556 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:10:15,767 DEBUG ModbusTCP Encoded value: (232, 39, 0, 0, 0, 0, 0, 0)

2020-06-30 17:10:15,768 DEBUG ModbusTCP value: 10216

2020-06-30 17:10:15,769 DEBUG ModbusTCP datacode H

2020-06-30 17:10:15,770 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:10:15,980 DEBUG ModbusTCP Encoded value: (138, 67)

2020-06-30 17:10:15,981 DEBUG ModbusTCP value: 17290

2020-06-30 17:10:15,982 DEBUG ModbusTCP datacode H

2020-06-30 17:10:15,982 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:10:16,025 DEBUG RFM2Pi 12 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:10:16,028 DEBUG RFM2Pi 12 Timestamp : 1593529816.02536

2020-06-30 17:10:16,028 DEBUG RFM2Pi 12 From Node : 5

2020-06-30 17:10:16,029 DEBUG RFM2Pi 12 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:10:16,029 DEBUG RFM2Pi 12 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:10:16,030 DEBUG RFM2Pi 12 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:10:16,194 DEBUG ModbusTCP Encoded value: (0, 0)

2020-06-30 17:10:16,194 DEBUG ModbusTCP value: 0

2020-06-30 17:10:16,195 DEBUG ModbusTCP datacode H

2020-06-30 17:10:16,196 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:10:16,272 DEBUG MQTT Publishing: emon/emonpi/power1 0

2020-06-30 17:10:16,274 DEBUG MQTT Publishing: emon/emonpi/power2 0

2020-06-30 17:10:16,276 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 0

2020-06-30 17:10:16,278 DEBUG MQTT Publishing: emon/emonpi/vrms 0

2020-06-30 17:10:16,281 DEBUG MQTT Publishing: emon/emonpi/t1 0

2020-06-30 17:10:16,283 DEBUG MQTT Publishing: emon/emonpi/t2 0

2020-06-30 17:10:16,286 DEBUG MQTT Publishing: emon/emonpi/t3 0

2020-06-30 17:10:16,288 DEBUG MQTT Publishing: emon/emonpi/t4 0

2020-06-30 17:10:16,290 DEBUG MQTT Publishing: emon/emonpi/t5 0

2020-06-30 17:10:16,291 DEBUG MQTT Publishing: emon/emonpi/t6 0

2020-06-30 17:10:16,293 DEBUG MQTT Publishing: emon/emonpi/pulsecount 1

2020-06-30 17:10:16,295 INFO MQTT Publishing: emonhub/rx/5/values 0,0,0,0,0,0,0,0,0,0,1

2020-06-30 17:10:16,416 DEBUG ModbusTCP Encoded value: (162, 138)

2020-06-30 17:10:16,417 DEBUG ModbusTCP value: 35490

2020-06-30 17:10:16,418 DEBUG ModbusTCP datacode H

2020-06-30 17:10:16,418 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:10:16,630 DEBUG ModbusTCP Encoded value: (36, 154)

2020-06-30 17:10:16,631 DEBUG ModbusTCP value: 39460

2020-06-30 17:10:16,631 DEBUG ModbusTCP datacode f

2020-06-30 17:10:16,632 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

Add a trailing comma.

Now the log says it sends to node 12 but still not visible in inputs!

There is another error In the log file but it seems unrelated


2020-06-30 17:50:11,711 INFO MainThread EmonHub emonHub emon-pi variant v3-beta

2020-06-30 17:50:11,712 INFO MainThread Opening hub...

2020-06-30 17:50:11,713 INFO MainThread Logging level set to DEBUG

2020-06-30 17:50:11,714 INFO MainThread Creating EmonHubJeeInterfacer 'RFM2Pi'

2020-06-30 17:50:11,717 DEBUG MainThread Opening serial port: /dev/ttyAMA0 @ 38400 bits/s

2020-06-30 17:50:13,731 INFO MainThread RFM2Pi device firmware version: OK

2020-06-30 17:50:13,732 INFO MainThread RFM2Pi device current settings: 8 33 4 71 255 0 0 0 0 25 99 211 0 184 11 184 11 184 11 184 11 184 11 0 0 0 0 (-67)

2020-06-30 17:50:13,733 INFO MainThread Setting RFM2Pi baseid: 5 (5i)

2020-06-30 17:50:14,735 INFO MainThread Setting RFM2Pi frequency: 433 (4b)

2020-06-30 17:50:15,738 INFO MainThread Setting RFM2Pi group: 210 (210g)

2020-06-30 17:50:16,740 INFO MainThread Setting RFM2Pi quiet: 1 (1q)

2020-06-30 17:50:17,742 INFO MainThread Setting RFM2Pi calibration: 230V (1p)

2020-06-30 17:50:18,745 DEBUG MainThread Setting RFM2Pi pubchannels: ['ToEmonCMS']

2020-06-30 17:50:18,746 DEBUG MainThread Setting RFM2Pi subchannels: ['ToRFM12']

2020-06-30 17:50:18,748 INFO MainThread Creating EmonHubMqttInterfacer 'MQTT'

2020-06-30 17:50:18,753 DEBUG MainThread Setting MQTT pubchannels: ['ToRFM12']

2020-06-30 17:50:18,754 DEBUG MainThread Setting MQTT subchannels: ['ToEmonCMS']

2020-06-30 17:50:18,754 INFO MainThread Setting MQTT node_format_enable: 1

2020-06-30 17:50:18,755 INFO MainThread Setting MQTT nodevar_format_enable: 1

2020-06-30 17:50:18,755 INFO MainThread Setting MQTT nodevar_format_basetopic: emon/

2020-06-30 17:50:18,758 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:50:18,759 INFO MainThread Creating EmonHubEmoncmsHTTPInterfacer 'emoncmsorg'

2020-06-30 17:50:18,760 DEBUG MainThread Setting emoncmsorg pubchannels: ['ToRFM12']

2020-06-30 17:50:18,761 DEBUG MainThread Setting emoncmsorg subchannels: ['ToEmonCMS']

2020-06-30 17:50:18,762 WARNING MainThread Setting emoncmsorg apikey: obscured

2020-06-30 17:50:18,762 INFO MainThread Setting emoncmsorg url: https://emoncms.org

2020-06-30 17:50:18,763 INFO MainThread Setting emoncmsorg senddata: 1

2020-06-30 17:50:18,764 INFO MainThread Setting emoncmsorg sendstatus: 1

2020-06-30 17:50:18,765 INFO MainThread Creating EmonModbusTcpInterfacer 'ModbusTCP'

2020-06-30 17:50:18,766 INFO MainThread pymodbus installed

2020-06-30 17:50:18,767 DEBUG MainThread EmonModbusTcpInterfacer args: 192.168.1.192 - 502

2020-06-30 17:50:18,770 INFO MainThread Opening modbusTCP connection: 502 @ 192.168.1.192

2020-06-30 17:50:18,771 INFO MainThread Modbustcp client Connected

2020-06-30 17:50:18,773 DEBUG MainThread Setting ModbusTCP rName: ['Inverter_status', 'AC_power_watts', 'AC_LifetimekWh', 'DayWh', 'mppt1', 'mppt2', 'Vmppt1', 'Vmppt2', 'PhVphA', 'PhVphB', 'PhVphC']

2020-06-30 17:50:18,773 DEBUG MainThread Setting ModbusTCP register: ['40118', '40092', '40102', '502', '40285', '40305', '40284', '40304', '40086', '40088', '40090']

2020-06-30 17:50:18,774 DEBUG MainThread Setting ModbusTCP nReg: ['1', '2', '2', '4', '1', '1', '1', '1', '2', '2', '2']

2020-06-30 17:50:18,775 DEBUG MainThread Setting ModbusTCP rType: ['uint16', 'float32', 'float32', 'uint64', 'uint16', 'uint16', 'uint16', 'uint16', 'float32', 'float32', 'float32']

2020-06-30 17:50:18,775 DEBUG MainThread Setting ModbusTCP nodeId: 12

2020-06-30 17:50:18,776 DEBUG MainThread Setting ModbusTCP pubchannels: ['ToRFM12']

2020-06-30 17:50:18,776 DEBUG MainThread Setting ModbusTCP interval: 1

2020-06-30 17:50:18,862 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:50:18,968 DEBUG RFM2Pi 1 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:50:18,971 DEBUG RFM2Pi 1 Timestamp : 1593532218.9681046

2020-06-30 17:50:18,971 DEBUG RFM2Pi 1 From Node : 5

2020-06-30 17:50:18,972 DEBUG RFM2Pi 1 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:50:18,972 DEBUG RFM2Pi 1 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:50:18,973 DEBUG RFM2Pi 1 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:50:19,060 INFO MQTT Connecting to MQTT Server

2020-06-30 17:50:19,077 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:50:19,164 INFO MQTT connection status: Connection successful

2020-06-30 17:50:19,165 DEBUG MQTT CONACK => Return code: 0

2020-06-30 17:50:19,166 DEBUG emoncmsorg Buffer size: 1

2020-06-30 17:50:19,180 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:50:19,268 INFO MQTT on_subscribe

2020-06-30 17:50:19,284 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0

2020-06-30 17:50:19,593 DEBUG RFM2Pi 2 NEW FRAME : OK 11 29 4 188 1 159 3 0 0 110 101 194 11 194 11 194 11 194 11 194 11 194 11 233 21 24 0 (-58)

2020-06-30 17:50:19,596 DEBUG RFM2Pi 2 Timestamp : 1593532219.5931525

2020-06-30 17:50:19,596 DEBUG RFM2Pi 2 From Node : 11

2020-06-30 17:50:19,597 DEBUG RFM2Pi 2 Values : [1053, 444, 927, 0, 259.66, 301, 301, 301, 301, 301, 301, 1578473]

2020-06-30 17:50:19,597 DEBUG RFM2Pi 2 RSSI : -58

2020-06-30 17:50:19,598 DEBUG RFM2Pi 2 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:50:19,598 DEBUG RFM2Pi 2 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:50:19,671 DEBUG MQTT Publishing: emon/3phase/powerL1 1053

2020-06-30 17:50:19,673 DEBUG MQTT Publishing: emon/3phase/powerL2 444

2020-06-30 17:50:19,674 DEBUG MQTT Publishing: emon/3phase/powerL3 927

2020-06-30 17:50:19,676 DEBUG MQTT Publishing: emon/3phase/power4 0

2020-06-30 17:50:19,677 DEBUG MQTT Publishing: emon/3phase/Vrms 259.66

2020-06-30 17:50:19,679 DEBUG MQTT Publishing: emon/3phase/temp1 301

2020-06-30 17:50:19,680 DEBUG MQTT Publishing: emon/3phase/temp2 301

2020-06-30 17:50:19,682 DEBUG MQTT Publishing: emon/3phase/temp3 301

2020-06-30 17:50:19,683 DEBUG MQTT Publishing: emon/3phase/temp4 301

2020-06-30 17:50:19,685 DEBUG MQTT Publishing: emon/3phase/temp5 301

2020-06-30 17:50:19,686 DEBUG MQTT Publishing: emon/3phase/temp6 301

2020-06-30 17:50:19,687 DEBUG MQTT Publishing: emon/3phase/pulse 1578473

2020-06-30 17:50:19,689 DEBUG MQTT Publishing: emon/3phase/rssi -58

2020-06-30 17:50:19,690 INFO MQTT Publishing: emonhub/rx/11/values 1053,444,927,0,259.66,301,301,301,301,301,301,1578473,-58

2020-06-30 17:50:19,781 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:50:19,782 DEBUG ModbusTCP datacode H

2020-06-30 17:50:19,782 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:50:19,988 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:50:19,989 DEBUG ModbusTCP value: 4

2020-06-30 17:50:19,990 DEBUG ModbusTCP datacode f

2020-06-30 17:50:19,990 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:50:20,201 DEBUG ModbusTCP Encoded value: (0, 80, 165, 69)

2020-06-30 17:50:20,202 DEBUG ModbusTCP value: 5290.0

2020-06-30 17:50:20,203 DEBUG ModbusTCP datacode f

2020-06-30 17:50:20,203 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:50:20,415 DEBUG ModbusTCP Encoded value: (23, 76, 68, 76)

2020-06-30 17:50:20,415 DEBUG ModbusTCP value: 51458140.0

2020-06-30 17:50:20,416 DEBUG ModbusTCP datacode Q

2020-06-30 17:50:20,416 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:50:20,629 DEBUG ModbusTCP Encoded value: (6, 42, 0, 0, 0, 0, 0, 0)

2020-06-30 17:50:20,630 DEBUG ModbusTCP value: 10758

2020-06-30 17:50:20,631 DEBUG ModbusTCP datacode H

2020-06-30 17:50:20,631 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:50:20,712 DEBUG RFM2Pi 4 NEW FRAME : OK 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 (-0)

2020-06-30 17:50:20,714 DEBUG RFM2Pi 4 Timestamp : 1593532220.711775

2020-06-30 17:50:20,715 DEBUG RFM2Pi 4 From Node : 5

2020-06-30 17:50:20,715 DEBUG RFM2Pi 4 Values : [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 1]

2020-06-30 17:50:20,716 DEBUG RFM2Pi 4 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:50:20,716 DEBUG RFM2Pi 4 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:50:20,842 DEBUG ModbusTCP Encoded value: (46, 234)

2020-06-30 17:50:20,843 DEBUG ModbusTCP value: 59950

2020-06-30 17:50:20,844 DEBUG ModbusTCP datacode H

2020-06-30 17:50:20,844 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:50:20,908 DEBUG MQTT Publishing: emon/emonpi/power1 0

2020-06-30 17:50:20,910 DEBUG MQTT Publishing: emon/emonpi/power2 0

2020-06-30 17:50:20,912 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 0

2020-06-30 17:50:20,913 DEBUG MQTT Publishing: emon/emonpi/vrms 0

2020-06-30 17:50:20,915 DEBUG MQTT Publishing: emon/emonpi/t1 0

2020-06-30 17:50:20,916 DEBUG MQTT Publishing: emon/emonpi/t2 0

2020-06-30 17:50:20,918 DEBUG MQTT Publishing: emon/emonpi/t3 0

2020-06-30 17:50:20,919 DEBUG MQTT Publishing: emon/emonpi/t4 0

2020-06-30 17:50:20,922 DEBUG MQTT Publishing: emon/emonpi/t5 0

2020-06-30 17:50:20,923 DEBUG MQTT Publishing: emon/emonpi/t6 0

2020-06-30 17:50:20,925 DEBUG MQTT Publishing: emon/emonpi/pulsecount 1

2020-06-30 17:50:20,926 INFO MQTT Publishing: emonhub/rx/5/values 0,0,0,0,0,0,0,0,0,0,1

2020-06-30 17:50:21,056 DEBUG ModbusTCP Encoded value: (147, 1)

2020-06-30 17:50:21,057 DEBUG ModbusTCP value: 403

2020-06-30 17:50:21,057 DEBUG ModbusTCP datacode H

2020-06-30 17:50:21,058 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:50:21,269 DEBUG ModbusTCP Encoded value: (152, 138)

2020-06-30 17:50:21,270 DEBUG ModbusTCP value: 35480

2020-06-30 17:50:21,271 DEBUG ModbusTCP datacode H

2020-06-30 17:50:21,271 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:50:21,482 DEBUG ModbusTCP Encoded value: (38, 157)

2020-06-30 17:50:21,483 DEBUG ModbusTCP value: 40230

2020-06-30 17:50:21,484 DEBUG ModbusTCP datacode f

2020-06-30 17:50:21,484 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

2020-06-30 17:50:21,697 DEBUG ModbusTCP Encoded value: (0, 80, 17, 69)

2020-06-30 17:50:21,697 DEBUG ModbusTCP value: 2325.0

2020-06-30 17:50:21,698 DEBUG ModbusTCP datacode f

2020-06-30 17:50:21,699 DEBUG ModbusTCP reading register # :40088, qty #: 2, unit #: 1

2020-06-30 17:50:21,931 DEBUG ModbusTCP Encoded value: (0, 240, 16, 69)

2020-06-30 17:50:21,932 DEBUG ModbusTCP value: 2318.9999389648438

2020-06-30 17:50:21,933 DEBUG ModbusTCP datacode f

2020-06-30 17:50:21,933 DEBUG ModbusTCP reading register # :40090, qty #: 2, unit #: 1

2020-06-30 17:50:22,033 DEBUG RFM2Pi 5 NEW FRAME : OK 8 62 4 72 255 0 0 0 0 202 99 211 0 184 11 184 11 184 11 184 11 184 11 0 0 0 0 (-70)

2020-06-30 17:50:22,035 DEBUG RFM2Pi 5 Timestamp : 1593532222.0327735

2020-06-30 17:50:22,036 DEBUG RFM2Pi 5 From Node : 8

2020-06-30 17:50:22,036 DEBUG RFM2Pi 5 Values : [3692.4, -184, 0, 0, 255.46, 21.1, 300, 300, 300, 300, 300, 0]

2020-06-30 17:50:22,037 DEBUG RFM2Pi 5 RSSI : -70

2020-06-30 17:50:22,037 DEBUG RFM2Pi 5 Sent to channel(start)' : ToEmonCMS

2020-06-30 17:50:22,038 DEBUG RFM2Pi 5 Sent to channel(end)' : ToEmonCMS

2020-06-30 17:50:22,139 DEBUG ModbusTCP Encoded value: (0, 32, 17, 69)

2020-06-30 17:50:22,140 DEBUG ModbusTCP value: 2321.999969482422

2020-06-30 17:50:22,141 DEBUG ModbusTCP payload size OK (38)

2020-06-30 17:50:22,141 DEBUG ModbusTCP reporting data: [4, 0, 0, 80, 165, 69, 23, 76, 68, 76, 6, 42, 0, 0, 0, 0, 0, 0, 46, 234, 147, 1, 152, 138, 38, 157, 0, 80, 17, 69, 0, 240, 16, 69, 0, 32, 17, 69]

2020-06-30 17:50:22,142 DEBUG ModbusTCP Return from read data: [4, 0, 0, 80, 165, 69, 23, 76, 68, 76, 6, 42, 0, 0, 0, 0, 0, 0, 46, 234, 147, 1, 152, 138, 38, 157, 0, 80, 17, 69, 0, 240, 16, 69, 0, 32, 17, 69]

2020-06-30 17:50:22,143 DEBUG ModbusTCP 3 NEW FRAME :

2020-06-30 17:50:22,145 DEBUG ModbusTCP 3 Timestamp : 1593532219.7804027

2020-06-30 17:50:22,146 DEBUG ModbusTCP 3 From Node : 12

2020-06-30 17:50:22,146 DEBUG ModbusTCP 3 Values : [4, 529, 5145814, 10758, 59950, 403, 35480, 40230, 232.5, 231.9, 232.20000000000002]

2020-06-30 17:50:22,147 DEBUG ModbusTCP 3 Sent to channel(start)' : ToRFM12

2020-06-30 17:50:22,147 DEBUG ModbusTCP 3 Sent to channel(end)' : ToRFM12

2020-06-30 17:50:22,149 DEBUG MQTT Publishing: emon/emontx3/power1 3692.4

2020-06-30 17:50:22,150 DEBUG MQTT Publishing: emon/emontx3/power2 -184

2020-06-30 17:50:22,152 DEBUG MQTT Publishing: emon/emontx3/power3 0

2020-06-30 17:50:22,153 DEBUG MQTT Publishing: emon/emontx3/power4 0

2020-06-30 17:50:22,154 DEBUG MQTT Publishing: emon/emontx3/vrms 255.46

2020-06-30 17:50:22,156 DEBUG MQTT Publishing: emon/emontx3/temp1 21.1

2020-06-30 17:50:22,157 DEBUG MQTT Publishing: emon/emontx3/temp2 300

2020-06-30 17:50:22,158 DEBUG MQTT Publishing: emon/emontx3/temp3 300

2020-06-30 17:50:22,159 DEBUG MQTT Publishing: emon/emontx3/temp4 300

2020-06-30 17:50:22,161 DEBUG MQTT Publishing: emon/emontx3/temp5 300

2020-06-30 17:50:22,163 DEBUG MQTT Publishing: emon/emontx3/temp6 300

2020-06-30 17:50:22,164 DEBUG MQTT Publishing: emon/emontx3/pulse 0

2020-06-30 17:50:22,166 DEBUG MQTT Publishing: emon/emontx3/rssi -70

2020-06-30 17:50:22,167 INFO MQTT Publishing: emonhub/rx/8/values 3692.4,-184,0,0,255.46,21.1,300,300,300,300,300,0,-70

2020-06-30 17:50:22,346 WARNING RFM2Pi Exception caught in RFM2Pi thread. Traceback (most recent call last):

File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 32, in wrapper

return f(*args)

File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 122, in run

self.add(frame)

File "/opt/openenergymonitor/emonhub/src/interfacers/EmonHubJeeInterfacer.py", line 73, in add

txc = self._process_tx(cargo)

File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 568, in _process_tx

for b in ehc.encode(dc, int(scaled[i])):

File "/opt/openenergymonitor/emonhub/src/emonhub_coder.py", line 39, in encode

return struct.unpack(e + b*s, struct.pack(e + datacode, value))

struct.error: short format requires (-0x7fff - 1) <= number <= 0x7fff

2020-06-30 17:50:22,533 WARNING MainThread RFM2Pi thread is dead.

2020-06-30 17:50:22,534 WARNING MainThread Attempting to restart thread RFM2Pi (thread has been restarted 0 times...

2020-06-30 17:50:22,535 INFO MainThread Creating EmonHubJeeInterfacer 'RFM2Pi'

2020-06-30 17:50:22,537 DEBUG MainThread Opening serial port: /dev/ttyAMA0 @ 38400 bits/s

2020-06-30 17:50:23,250 DEBUG ModbusTCP expected bytes number after encoding: 38

2020-06-30 17:50:23,251 DEBUG ModbusTCP datacode H

2020-06-30 17:50:23,252 DEBUG ModbusTCP reading register # :40118, qty #: 1, unit #: 1

2020-06-30 17:50:23,457 DEBUG ModbusTCP Encoded value: (4, 0)

2020-06-30 17:50:23,458 DEBUG ModbusTCP value: 4

2020-06-30 17:50:23,459 DEBUG ModbusTCP datacode f

2020-06-30 17:50:23,459 DEBUG ModbusTCP reading register # :40092, qty #: 2, unit #: 1

2020-06-30 17:50:23,671 DEBUG ModbusTCP Encoded value: (0, 240, 165, 69)

2020-06-30 17:50:23,672 DEBUG ModbusTCP value: 5310.0

2020-06-30 17:50:23,672 DEBUG ModbusTCP datacode f

2020-06-30 17:50:23,673 DEBUG ModbusTCP reading register # :40102, qty #: 2, unit #: 1

2020-06-30 17:50:23,884 DEBUG ModbusTCP Encoded value: (24, 76, 68, 76)

2020-06-30 17:50:23,885 DEBUG ModbusTCP value: 51458145.0

2020-06-30 17:50:23,885 DEBUG ModbusTCP datacode Q

2020-06-30 17:50:23,886 DEBUG ModbusTCP reading register # :502, qty #: 4, unit #: 1

2020-06-30 17:50:24,097 DEBUG ModbusTCP Encoded value: (7, 42, 0, 0, 0, 0, 0, 0)

2020-06-30 17:50:24,098 DEBUG ModbusTCP value: 10759

2020-06-30 17:50:24,099 DEBUG ModbusTCP datacode H

2020-06-30 17:50:24,100 DEBUG ModbusTCP reading register # :40285, qty #: 1, unit #: 1

2020-06-30 17:50:24,310 DEBUG ModbusTCP Encoded value: (144, 236)

2020-06-30 17:50:24,311 DEBUG ModbusTCP value: 60560

2020-06-30 17:50:24,312 DEBUG ModbusTCP datacode H

2020-06-30 17:50:24,312 DEBUG ModbusTCP reading register # :40305, qty #: 1, unit #: 1

2020-06-30 17:50:24,524 DEBUG ModbusTCP Encoded value: (147, 1)

2020-06-30 17:50:24,524 DEBUG ModbusTCP value: 403

2020-06-30 17:50:24,525 DEBUG ModbusTCP datacode H

2020-06-30 17:50:24,526 DEBUG ModbusTCP reading register # :40284, qty #: 1, unit #: 1

2020-06-30 17:50:24,544 INFO MainThread RFM2Pi device firmware version & configuration: not available

2020-06-30 17:50:24,546 INFO MainThread Setting RFM2Pi baseid: 5 (5i)

2020-06-30 17:50:24,737 DEBUG ModbusTCP Encoded value: (92, 138)

2020-06-30 17:50:24,737 DEBUG ModbusTCP value: 35420

2020-06-30 17:50:24,738 DEBUG ModbusTCP datacode H

2020-06-30 17:50:24,739 DEBUG ModbusTCP reading register # :40304, qty #: 1, unit #: 1

2020-06-30 17:50:24,950 DEBUG ModbusTCP Encoded value: (78, 157)

2020-06-30 17:50:24,951 DEBUG ModbusTCP value: 40270

2020-06-30 17:50:24,951 DEBUG ModbusTCP datacode f

2020-06-30 17:50:24,952 DEBUG ModbusTCP reading register # :40086, qty #: 2, unit #: 1

2020-06-30 17:50:25,163 DEBUG ModbusTCP Encoded value: (0, 176, 16, 69)

2020-06-30 17:50:25,164 DEBUG ModbusTCP value: 2315.0

2020-06-30 17:50:25,165 DEBUG ModbusTCP datacode f

2020-06-30 17:50:25,165 DEBUG ModbusTCP reading register # :40088, qty #: 2, unit #: 1

2020-06-30 17:50:25,376 DEBUG ModbusTCP Encoded value: (0, 16, 18, 69)

2020-06-30 17:50:25,377 DEBUG ModbusTCP value: 2336.999969482422

2020-06-30 17:50:25,378 DEBUG ModbusTCP datacode f

2020-06-30 17:50:25,378 DEBUG ModbusTCP reading register # :40090, qty #: 2, unit #: 1

2020-06-30 17:50:25,547 INFO MainThread Setting RFM2Pi frequency: 433 (4b)

2020-06-30 17:50:25,589 DEBUG ModbusTCP Encoded value: (0, 48, 17, 69)

2020-06-30 17:50:25,590 DEBUG ModbusTCP value: 2323.000030517578

2020-06-30 17:50:25,591 DEBUG ModbusTCP payload size OK (38)

2020-06-30 17:50:25,592 DEBUG ModbusTCP reporting data: [4, 0, 0, 240, 165, 69, 24, 76, 68, 76, 7, 42, 0, 0, 0, 0, 0, 0, 144, 236, 147, 1, 92, 138, 78, 157, 0, 176, 16, 69, 0, 16, 18, 69, 0, 48, 17, 69]

2020-06-30 17:50:25,592 DEBUG ModbusTCP Return from read data: [4, 0, 0, 240, 165, 69, 24, 76, 68, 76, 7, 42, 0, 0, 0, 0, 0, 0, 144, 236, 147, 1, 92, 138, 78, 157, 0, 176, 16, 69, 0, 16, 18, 69, 0, 48, 17, 69]

2020-06-30 17:50:25,593 DEBUG ModbusTCP 6 NEW FRAME :

2020-06-30 17:50:25,595 DEBUG ModbusTCP 6 Timestamp : 1593532223.249751

2020-06-30 17:50:25,596 DEBUG ModbusTCP 6 From Node : 12

2020-06-30 17:50:25,596 DEBUG ModbusTCP 6 Values : [4, 531, 5145814.4, 10759, 60560, 403, 35420, 40270, 231.5, 233.70000000000002, 232.3]

2020-06-30 17:50:25,597 DEBUG ModbusTCP 6 Sent to channel(start)' : ToRFM12

2020-06-30 17:50:25,597 DEBUG ModbusTCP 6 Sent to channel(end)' : ToRFM12

Because you are sending it to the wrong pubchannel.

I am guessing it should be ToEmonCMS but as you did not post the full config, I can’t be sure.

It helps when you know what you are doing :blush:

Works now

THX a lot

1 Like

I have raised a PR so it should be installed in future

I also have a PR in to update the documentation which might make it clearer if it is actually read… :grinning:.

Hi, can someone help me out with a similar problem here?

Mine is also unable to start the TCP interfacer with the error PYMODBUS NOT PRESENT BUT NEEDED !! - but it my case it is installed as can be seen below.


2021-06-28 06:32:41,629 DEBUG    MainThread Setting VEDirect2 subchannels: ['ToVictronControl2']
2021-06-28 06:32:41,629 DEBUG    MainThread Setting VEDirect2 pubchannels: ['ToEmonCMS']
2021-06-28 06:32:41,630 INFO     MainThread Creating EmonModbusTcpInterfacer 'ModbusTCP' 
2021-06-28 06:32:41,631 ERROR    MainThread PYMODBUS NOT PRESENT BUT NEEDED !!
2021-06-28 06:32:41,631 DEBUG    MainThread Setting ModbusTCP nUnit: ['239', '239', '100', '100']
2021-06-28 06:32:41,632 DEBUG    MainThread Setting ModbusTCP rName: ['Battery State of Charge (System)', 'Input Voltage Phase 1', 'Grid Power', 'Battery Power']
2021-06-28 06:32:41,632 DEBUG    MainThread Setting ModbusTCP interval: 10
2021-06-28 06:32:41,632 DEBUG    MainThread Setting ModbusTCP nReg: ['1', '1', '1', '1']
2021-06-28 06:32:41,632 DEBUG    MainThread Setting ModbusTCP rType: ['uint16', 'uint16', 'uint16', 'int16']
2021-06-28 06:32:41,633 DEBUG    MainThread Setting ModbusTCP register: ['31', '4', '821', '843']
2021-06-28 06:32:41,633 DEBUG    MainThread Setting ModbusTCP nodeId: 27
2021-06-28 06:32:41,633 DEBUG    MainThread Setting ModbusTCP pubchannels: ['ToEmonCMS']
2021-06-28 06:32:41,634 INFO     MainThread Creating EmonHubSerialInterfacer 'SerialDirect' 
2021-06-28 06:32:41,638 DEBUG    MainThread Opening serial port: /dev/ttyACM0 @ 115200 bits/s
2021-06-28 06:32:41,638 DEBUG    MainThread Setting SerialDirect pubchannels: ['ToEmonCMS']
2021-06-28 06:32:41,710 DEBUG    RFM2Pi     device settings updated: E i5 g210 @ 433 MHz
2021-06-28 06:32:41,759 WARNING  SerialDirect Exception caught in SerialDirect thread. Traceback (most recent call last):
  File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 40, in wrapper
    return f(*args)
  File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 102, in run
    rxc = self.read()
  File "/opt/openenergymonitor/emonhub/src/interfacers/EmonHubSerialInterfacer.py", line 90, in read
    c.nodeid = int(f[0])
IndexError: list index out of range

2021-06-28 06:32:41,810 DEBUG    RFM2Pi     acknowledged command: > 2p
2021-06-28 06:32:41,858 WARNING  MainThread SerialDirect thread is dead.
2021-06-28 06:32:41,864 WARNING  MainThread Attempting to restart thread SerialDirect (thread has been restarted 0 times...
2021-06-28 06:32:41,865 INFO     MainThread Setting RFM2Pi quiet: 0 (0q)
2021-06-28 06:32:42,114 DEBUG    RFM2Pi     acknowledged command: <nn> i     - set node ID (standard node ids are 1..30)

I hav rebooted many times, so not really sure what’s going on.

pi@emonpi:~ $ sudo apt-get install python3-pymodbus
Reading package lists... Done
Building dependency tree
Reading state information... Done
python3-pymodbus is already the newest version (2.1.0+dfsg-1).
0 upgraded, 0 newly installed, 0 to remove and 202 not upgraded.

Model: Raspberry Pi 4 Model B
emonpiRelease: emonSD-17Oct19
OS: Linux 4.19.75-v7l+
Branch : * stable
Describe : 10.5.6

Hello @wainsley64, do you have the latest version of emonhub? v2.2.7? It looks like you have latest emoncms but I just wonder if there is a chance that emonhub did not fully update?

aaah, yes…
seems like I have an old version.

2021-06-28 06:32:37,594 INFO     MainThread EmonHub emonHub emon-pi variant v2.1.2

Also seems like it refuses to update for some reason.

emonHub update<br />
-------------------------------------------------------------<br />
Migrating from emon-pi branch to stable branch<br />
Updating /opt/openenergymonitor/emonhub<br />
- current branch: emon-pi<br />
WARNING local changes in /opt/openenergymonitor/emonhub - Module not updated<br />
- git status: On branch emon-pi<br />
Your branch is behind 'origin/emon-pi' by 13 commits, and can be fast-forwarded.<br />
  (use "git pull" to update your local branch)<br />
<br />
Changes not staged for commit:<br />
  (use "git add ..." to update what will be committed)<br />
  (use "git checkout -- ..." to discard changes in working directory)<br />
<br />
	modified:   src/interfacers/__init__.py<br />
<br />
Untracked files:<br />
  (use "git add ..." to include in what will be committed)<br />
<br />
	src/interfacers/EmonHubVEDirectInterfacer2.py<br />
	src/interfacers/EmonHubVEDirectInterfacer3.py<br />
	src/src<br />
<br />
no changes added to commit (use "git add" and/or "git commit -a")<br />
<br />
<br />
-------------------------------------------------------------<br />
emonPi update done: Mon 28 Jun 08:48:55 EST 2021<br />
-------------------------------------------------------------</details><br />

I think it has to do with the fact that some years ago I had to modify the VEDirectInterfacer.py files because I have two identical MPPT charge controllers plugged into USB and they were conflicting.

Hi again,
so I managed to update the emonhub to 2.2.6
but looks like I also destroyed something in the process.
on the admin services screen emonhub is just stuck at “Activating - Auto-restart” with a red light

2021-06-28 10:01:25.679|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:25.868|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:25.909|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:25.963|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:25.993|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.118|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.164|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.186|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.317|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.318|WARN|emoncms_mqtt.php|Not connected, retrying connection
2021-06-28 10:01:26.340|WARN|emoncms_mqtt.php|Connecting to MQTT server: Connection Accepted.: code: 0
2021-06-28 10:01:26.361|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.373|ERROR|index.php|Not Authenticated|config/getemonhublog
2021-06-28 10:01:26.438|ERROR|index.php|Not Authenticated|config/getemonhublog

can you please help me out and let me know which log file to check ?
not seeing anything useful in any of the regular log files.
trying to figure out where the issue might be.
All inputs have now stopped working

Thanks again.

Hello @wainsley64 sorry for the delay, how did update emonhub? You could try:

sudo service emonhub stop
cd /opt/openenergymonitor/emonhub
python3 src/emonhub.py --config-file="/etc/emonhub/emonhub.conf"

It may then start and exit with an error that might help us get further.

Perhaps check emonhub.conf for any duplicate node entries as well?

Hi thanks for getting back.
I didn’t get this to work, so I just start a new installation from scratch.
I got the timeseries databases to import afterwords so most of the time spent was to rebuild dashboards.

Back to normal now.
Thanks again.