Ouch.
We didn’t like that…
2021-01-21 08:54:21,246 DEBUG MainThread Signal 15 received.
2021-01-21 08:54:21,330 INFO MainThread Exiting hub...
2021-01-21 08:54:27,389 WARNING SDM120 Exception caught in SDM120 thread. Traceback (most recent call last):
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 32, in wrapper
return func(*args)
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 99, in run
rxc = self.read()
File "/opt/openenergymonitor/emonhub/src/interfacers/EmonHubSDM120Interfacer.py", line 76, in read
self._log.debug("%.2f %.2f %.4f %.4f %.3f %.3f" % (r['voltage'],r['power_active'],r['power_factor'],r['frequency'],r['import_energy_active'],r['current']))
KeyError: 'voltage'
2021-01-21 08:54:27,390 INFO MainThread Exit completed
2021-01-21 08:54:29,996 INFO MainThread EmonHub emonHub (emon-pi variant) v2.1.5
2021-01-21 08:54:29,997 INFO MainThread Opening hub...
2021-01-21 08:54:29,998 INFO MainThread Logging level set to DEBUG
2021-01-21 08:54:29,999 INFO MainThread Creating EmonHubJeeInterfacer 'RFM2Pi'
2021-01-21 08:54:30,001 DEBUG MainThread Opening serial port: /dev/ttyAMA0 @ 38400 bits/s
2021-01-21 08:54:32,008 INFO MainThread RFM2Pi device firmware version & configuration: not available
2021-01-21 08:54:32,010 INFO MainThread Setting RFM2Pi baseid: 5 (5i)
2021-01-21 08:54:33,012 INFO MainThread Setting RFM2Pi frequency: 433 (4b)
2021-01-21 08:54:34,014 INFO MainThread Setting RFM2Pi group: 210 (210g)
2021-01-21 08:54:35,016 INFO MainThread Setting RFM2Pi quiet: 1 (1q)
2021-01-21 08:54:36,019 INFO MainThread Setting RFM2Pi calibration: 230V (1p)
2021-01-21 08:54:37,021 DEBUG MainThread Setting RFM2Pi pubchannels: ['ToEmonCMS']
2021-01-21 08:54:37,022 DEBUG MainThread Setting RFM2Pi subchannels: ['ToRFM12']
2021-01-21 08:54:37,024 INFO MainThread Creating EmonHubMqttInterfacer 'MQTT'
2021-01-21 08:54:37,029 DEBUG MainThread Setting MQTT pubchannels: ['ToRFM12']
2021-01-21 08:54:37,030 DEBUG MainThread Setting MQTT subchannels: ['ToEmonCMS']
2021-01-21 08:54:37,031 INFO MainThread Setting MQTT node_format_enable: 1
2021-01-21 08:54:37,032 INFO MainThread Setting MQTT nodevar_format_enable: 1
2021-01-21 08:54:37,032 INFO MainThread Setting MQTT nodevar_format_basetopic: emon/
2021-01-21 08:54:37,034 INFO MainThread Creating EmonHubEmoncmsHTTPInterfacer 'emoncmsorg'
2021-01-21 08:54:37,036 DEBUG MainThread Setting emoncmsorg pubchannels: ['ToRFM12']
2021-01-21 08:54:37,037 DEBUG MainThread Setting emoncmsorg subchannels: ['ToEmonCMS']
2021-01-21 08:54:37,038 WARNING MainThread Setting emoncmsorg apikey: obscured
2021-01-21 08:54:37,038 INFO MainThread Setting emoncmsorg url: https://emoncms.org
2021-01-21 08:54:37,039 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:37,039 INFO MainThread Setting emoncmsorg senddata: 1
2021-01-21 08:54:37,040 INFO MainThread Setting emoncmsorg sendstatus: 1
2021-01-21 08:54:37,042 INFO MainThread Creating EmonHubSDM120Interfacer 'SDM120'
2021-01-21 08:54:37,052 INFO MainThread Connecting to SDM120 device=/dev/ttyUSB0 baud=2400
2021-01-21 08:54:37,054 INFO MainThread Setting SDM120 read_interval: 10
2021-01-21 08:54:37,055 INFO MainThread Setting SDM120 nodename: SDM120
2021-01-21 08:54:37,055 DEBUG MainThread Setting SDM120 pubchannels: ['ToEmonCMS']
2021-01-21 08:54:37,142 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:37,246 DEBUG RFM2Pi 1 NEW FRAME : OK 5 116 252 234 255 94 252 104 92 0 0 0 0 0 0 0 0 0 0 0 0 221 137 0 0 (-0)
2021-01-21 08:54:37,247 DEBUG RFM2Pi 1 Timestamp : 1611219277.245972
2021-01-21 08:54:37,247 DEBUG RFM2Pi 1 From Node : 5
2021-01-21 08:54:37,248 DEBUG RFM2Pi 1 Values : [-908, -22, -930, 236.56, 0, 0, 0, 0, 0, 0, 35293]
2021-01-21 08:54:37,248 DEBUG RFM2Pi 1 Sent to channel(start)' : ToEmonCMS
2021-01-21 08:54:37,248 DEBUG RFM2Pi 1 Sent to channel(end)' : ToEmonCMS
2021-01-21 08:54:37,335 INFO MQTT Connecting to MQTT Server
2021-01-21 08:54:37,350 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:37,437 INFO MQTT connection status: Connection successful
2021-01-21 08:54:37,438 DEBUG MQTT CONACK => Return code: 0
2021-01-21 08:54:37,443 DEBUG emoncmsorg Buffer size: 1
2021-01-21 08:54:37,452 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:37,539 INFO MQTT on_subscribe
2021-01-21 08:54:37,554 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:38,765 DEBUG RFM2Pi 2 NEW FRAME : OK 5 110 252 233 255 87 252 60 92 0 0 0 0 0 0 0 0 0 0 0 0 225 137 0 0 (-0)
2021-01-21 08:54:38,768 DEBUG RFM2Pi 2 Timestamp : 1611219278.765470
2021-01-21 08:54:38,769 DEBUG RFM2Pi 2 From Node : 5
2021-01-21 08:54:38,769 DEBUG RFM2Pi 2 Values : [-914, -23, -937, 236.12, 0, 0, 0, 0, 0, 0, 35297]
2021-01-21 08:54:38,770 DEBUG RFM2Pi 2 Sent to channel(start)' : ToEmonCMS
2021-01-21 08:54:38,770 DEBUG RFM2Pi 2 Sent to channel(end)' : ToEmonCMS
2021-01-21 08:54:38,945 DEBUG MQTT Publishing: emon/emonpi/power1 -914
2021-01-21 08:54:38,948 DEBUG MQTT Publishing: emon/emonpi/power2 -23
2021-01-21 08:54:38,949 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 -937
2021-01-21 08:54:38,951 DEBUG MQTT Publishing: emon/emonpi/vrms 236.12
2021-01-21 08:54:38,952 DEBUG MQTT Publishing: emon/emonpi/t1 0
2021-01-21 08:54:38,954 DEBUG MQTT Publishing: emon/emonpi/t2 0
2021-01-21 08:54:38,956 DEBUG MQTT Publishing: emon/emonpi/t3 0
2021-01-21 08:54:38,959 DEBUG MQTT Publishing: emon/emonpi/t4 0
2021-01-21 08:54:38,961 DEBUG MQTT Publishing: emon/emonpi/t5 0
2021-01-21 08:54:38,962 DEBUG MQTT Publishing: emon/emonpi/t6 0
2021-01-21 08:54:38,964 DEBUG MQTT Publishing: emon/emonpi/pulsecount 35297
2021-01-21 08:54:38,965 INFO MQTT Publishing 'node' formatted msg
2021-01-21 08:54:38,966 DEBUG MQTT Publishing: emonhub/rx/5/values -914,-23,-937,236.12,0,0,0,0,0,0,35297
2021-01-21 08:54:43,810 DEBUG RFM2Pi 4 NEW FRAME : OK 5 102 252 234 255 80 252 84 92 0 0 0 0 0 0 0 0 0 0 0 0 229 137 0 0 (-0)
2021-01-21 08:54:43,812 DEBUG RFM2Pi 4 Timestamp : 1611219283.809912
2021-01-21 08:54:43,813 DEBUG RFM2Pi 4 From Node : 5
2021-01-21 08:54:43,814 DEBUG RFM2Pi 4 Values : [-922, -22, -944, 236.36, 0, 0, 0, 0, 0, 0, 35301]
2021-01-21 08:54:43,815 DEBUG RFM2Pi 4 Sent to channel(start)' : ToEmonCMS
2021-01-21 08:54:43,815 DEBUG RFM2Pi 4 Sent to channel(end)' : ToEmonCMS
2021-01-21 08:54:44,004 DEBUG MQTT Publishing: emon/emonpi/power1 -922
2021-01-21 08:54:44,006 DEBUG MQTT Publishing: emon/emonpi/power2 -22
2021-01-21 08:54:44,008 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 -944
2021-01-21 08:54:44,010 DEBUG MQTT Publishing: emon/emonpi/vrms 236.36
2021-01-21 08:54:44,012 DEBUG MQTT Publishing: emon/emonpi/t1 0
2021-01-21 08:54:44,013 DEBUG MQTT Publishing: emon/emonpi/t2 0
2021-01-21 08:54:44,015 DEBUG MQTT Publishing: emon/emonpi/t3 0
2021-01-21 08:54:44,017 DEBUG MQTT Publishing: emon/emonpi/t4 0
2021-01-21 08:54:44,019 DEBUG MQTT Publishing: emon/emonpi/t5 0
2021-01-21 08:54:44,021 DEBUG MQTT Publishing: emon/emonpi/t6 0
2021-01-21 08:54:44,023 DEBUG MQTT Publishing: emon/emonpi/pulsecount 35301
2021-01-21 08:54:44,025 INFO MQTT Publishing 'node' formatted msg
2021-01-21 08:54:44,025 DEBUG MQTT Publishing: emonhub/rx/5/values -922,-22,-944,236.36,0,0,0,0,0,0,35301
2021-01-21 08:54:47,474 WARNING SDM120 Exception caught in SDM120 thread. Traceback (most recent call last):
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 32, in wrapper
return func(*args)
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 99, in run
rxc = self.read()
File "/opt/openenergymonitor/emonhub/src/interfacers/EmonHubSDM120Interfacer.py", line 76, in read
self._log.debug("%.2f %.2f %.4f %.4f %.3f %.3f" % (r['voltage'],r['power_active'],r['power_factor'],r['frequency'],r['import_energy_active'],r['current']))
KeyError: 'voltage'
2021-01-21 08:54:47,672 WARNING MainThread SDM120 thread is dead.
2021-01-21 08:54:47,673 WARNING MainThread Attempting to restart thread SDM120 (thread has been restarted 0 times...)
2021-01-21 08:54:47,674 INFO MainThread Setting RFM2Pi calibration: 230V (1p)
2021-01-21 08:54:47,737 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:48,676 INFO MainThread Creating EmonHubSDM120Interfacer 'SDM120'
2021-01-21 08:54:48,678 INFO MainThread Connecting to SDM120 device=/dev/ttyUSB0 baud=2400
2021-01-21 08:54:48,679 INFO MainThread Setting SDM120 read_interval: 10
2021-01-21 08:54:48,679 INFO MainThread Setting SDM120 nodename: SDM120
2021-01-21 08:54:48,680 DEBUG MainThread Setting SDM120 pubchannels: ['ToEmonCMS']
2021-01-21 08:54:48,748 DEBUG RFM2Pi 5 NEW FRAME : OK 5 104 252 234 255 82 252 57 92 0 0 0 0 0 0 0 0 0 0 0 0 233 137 0 0 (-0)
2021-01-21 08:54:48,750 DEBUG RFM2Pi 5 Timestamp : 1611219288.747883
2021-01-21 08:54:48,751 DEBUG RFM2Pi 5 From Node : 5
2021-01-21 08:54:48,751 DEBUG RFM2Pi 5 Values : [-920, -22, -942, 236.09, 0, 0, 0, 0, 0, 0, 35305]
2021-01-21 08:54:48,752 DEBUG RFM2Pi 5 Sent to channel(start)' : ToEmonCMS
2021-01-21 08:54:48,753 DEBUG RFM2Pi 5 Sent to channel(end)' : ToEmonCMS
2021-01-21 08:54:48,963 DEBUG MQTT Publishing: emon/emonpi/power1 -920
2021-01-21 08:54:48,964 DEBUG MQTT Publishing: emon/emonpi/power2 -22
2021-01-21 08:54:48,966 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 -942
2021-01-21 08:54:48,967 DEBUG MQTT Publishing: emon/emonpi/vrms 236.09
2021-01-21 08:54:48,968 DEBUG MQTT Publishing: emon/emonpi/t1 0
2021-01-21 08:54:48,970 DEBUG MQTT Publishing: emon/emonpi/t2 0
2021-01-21 08:54:48,971 DEBUG MQTT Publishing: emon/emonpi/t3 0
2021-01-21 08:54:48,972 DEBUG MQTT Publishing: emon/emonpi/t4 0
2021-01-21 08:54:48,974 DEBUG MQTT Publishing: emon/emonpi/t5 0
2021-01-21 08:54:48,975 DEBUG MQTT Publishing: emon/emonpi/t6 0
2021-01-21 08:54:48,977 DEBUG MQTT Publishing: emon/emonpi/pulsecount 35305
2021-01-21 08:54:48,979 INFO MQTT Publishing 'node' formatted msg
2021-01-21 08:54:48,979 DEBUG MQTT Publishing: emonhub/rx/5/values -920,-22,-942,236.09,0,0,0,0,0,0,35305
2021-01-21 08:54:53,792 DEBUG RFM2Pi 7 NEW FRAME : OK 5 115 252 234 255 93 252 227 91 0 0 0 0 0 0 0 0 0 0 0 0 237 137 0 0 (-0)
2021-01-21 08:54:53,794 DEBUG RFM2Pi 7 Timestamp : 1611219293.791961
2021-01-21 08:54:53,795 DEBUG RFM2Pi 7 From Node : 5
2021-01-21 08:54:53,796 DEBUG RFM2Pi 7 Values : [-909, -22, -931, 235.23000000000002, 0, 0, 0, 0, 0, 0, 35309]
2021-01-21 08:54:53,796 DEBUG RFM2Pi 7 Sent to channel(start)' : ToEmonCMS
2021-01-21 08:54:53,797 DEBUG RFM2Pi 7 Sent to channel(end)' : ToEmonCMS
2021-01-21 08:54:53,916 DEBUG MQTT Publishing: emon/emonpi/power1 -909
2021-01-21 08:54:53,918 DEBUG MQTT Publishing: emon/emonpi/power2 -22
2021-01-21 08:54:53,919 DEBUG MQTT Publishing: emon/emonpi/power1pluspower2 -931
2021-01-21 08:54:53,921 DEBUG MQTT Publishing: emon/emonpi/vrms 235.23000000000002
2021-01-21 08:54:53,922 DEBUG MQTT Publishing: emon/emonpi/t1 0
2021-01-21 08:54:53,924 DEBUG MQTT Publishing: emon/emonpi/t2 0
2021-01-21 08:54:53,925 DEBUG MQTT Publishing: emon/emonpi/t3 0
2021-01-21 08:54:53,927 DEBUG MQTT Publishing: emon/emonpi/t4 0
2021-01-21 08:54:53,928 DEBUG MQTT Publishing: emon/emonpi/t5 0
2021-01-21 08:54:53,929 DEBUG MQTT Publishing: emon/emonpi/t6 0
2021-01-21 08:54:53,931 DEBUG MQTT Publishing: emon/emonpi/pulsecount 35309
2021-01-21 08:54:53,932 INFO MQTT Publishing 'node' formatted msg
2021-01-21 08:54:53,933 DEBUG MQTT Publishing: emonhub/rx/5/values -909,-22,-931,235.23000000000002,0,0,0,0,0,0,35309
2021-01-21 08:54:57,453 WARNING SDM120 Exception caught in SDM120 thread. Traceback (most recent call last):
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 32, in wrapper
return func(*args)
File "/opt/openenergymonitor/emonhub/src/emonhub_interfacer.py", line 99, in run
rxc = self.read()
File "/opt/openenergymonitor/emonhub/src/interfacers/EmonHubSDM120Interfacer.py", line 76, in read
self._log.debug("%.2f %.2f %.4f %.4f %.3f %.3f" % (r['voltage'],r['power_active'],r['power_factor'],r['frequency'],r['import_energy_active'],r['current']))
KeyError: 'voltage'
2021-01-21 08:54:57,643 WARNING MainThread SDM120 thread is dead.
2021-01-21 08:54:57,644 WARNING MainThread Attempting to restart thread SDM120 (thread has been restarted 1 times...)
2021-01-21 08:54:57,646 INFO MainThread Setting RFM2Pi calibration: 230V (1p)
2021-01-21 08:54:57,727 DEBUG RFM2Pi device settings updated: E i5 g210 @ 433 MHz q1 USA 0
2021-01-21 08:54:58,648 INFO MainThread Creating EmonHubSDM120Interfacer 'SDM120'
2021-01-21 08:54:58,650 INFO MainThread Connecting to SDM120 device=/dev/ttyUSB0 baud=2400
2021-01-21 08:54:58,651 INFO MainThread Setting SDM120 read_interval: 10
2021-01-21 08:54:58,652 INFO MainThread Setting SDM120 nodename: SDM120
2021-01-21 08:54:58,652 DEBUG MainThread Setting SDM120 pubchannels: ['ToEmonCMS']
et cetera…