Plugwise Plugs component

bouwew · August 12, 2020, 1:02pm

After updating to Core 0.114.0, I’m seeing this in Logs:

Log Details (ERROR)
Logger: root
Source: /usr/src/homeassistant/homeassistant/bootstrap.py:313
First occurred: 2:57:56 PM (1 occurrences)
Last logged: 2:57:56 PM

Uncaught thread exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.8/threading.py", line 932, in _bootstrap_inner
    self.run()
  File "/usr/local/lib/python3.8/threading.py", line 870, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/local/lib/python3.8/site-packages/plugwise/stick.py", line 701, in _watchdog_loop
    if not self.connection.read_thread_alive():
  File "/usr/local/lib/python3.8/site-packages/plugwise/connections/connection.py", line 103, in read_thread_alive
    return self._reader_thread.isAlive() if run_reader_thread else False
NameError: name 'run_reader_thread' is not defined

brefra · August 12, 2020, 6:09pm

Thanks @bouwew for reporting the exception.
I’ve fixed this in the updated v1.2.1 release. Please update the custom Integration from HACS.

bouwew · August 21, 2020, 1:24pm

@brefa, an observation and some feedback, if you don’t mind

I see you are showing as an attribute the “today_energy_kwh” value. When looking at the value: 0.002 at the moment, and looking at my own sensor for the same entity: 2.2, it looks like your value is a factor 1000 wrong.

I also see that you are showing the device_class “outlet” as an attribute.
FYI, switches don’t have device classes, see here: https://www.home-assistant.io/docs/configuration/customizing-devices/#device-class
Click on each entity to see the allowed device_classes per type of entity.

brefra · August 21, 2020, 8:32pm

@bouwew, I’m happy with any feedback

Nice catch, the today_energy_kwh is definitely miscalculated. I have fixed it in the latest version 1.2.2.

I have assigned the “outlet” device_class according to this development page. Apparently the user documentation is kind of missing the switch entity.
Do you experience any negative behavior due to this device_class setting?

bouwew · August 22, 2020, 8:17am

Thanks for the fix, the value is correct now.

Also, thanks for the link, I hadn’t looked there
Indeed, the documentation is not great.

bouwew · August 25, 2020, 11:54am

Just FYI, not to steal your thunder @brefa , initial support for the Plugwise Stretch with firmware 3.1 is available in Plugwise-beta. Please leave a message in the Plugwise Smile custom_component (BETA) topic if you are interested in helping us test.

bouwew · August 31, 2020, 4:51pm

@brefa I just noticed that after the latest update the sensors for power_consumption_today_xyz and power_consumption_yesterday_xyz are always zero.

brefra · September 6, 2020, 8:31pm

@bouwew, sorry I cannot reproduce the problem you are reporting. Do you experience this for all plugs and do the values remain at 0 even after one day?
If possible could you collect some debug logging of the startup process (first few minutes should be enough) so I’m able to investigate this.

logger:
  default: warning
  logs:
    custom_components.plugwise_stick: debug
    python-plugwise: debug

Sneak preview for next release:
Getting support for Scan devices and automatic accepting (joining) of new or reset devices is almost finished:

Still some code polishing and reorganization to do…

bouwew · September 7, 2020, 6:21am

I’ve just checked again: false alarm, the numbers are no longer 0
Must have been a glitch in my system, sorry!

lll.co · September 11, 2020, 8:10pm

Hi, first off thank you for all your hard work. I was very excited to see that my plugs aren’t useless anymore. I do have a problem with configuring the USB stick. It gives me the following error: ‘Initialization of Plugwise USB-stick failed’ when selecting the stick. I followed the 3 steps written in the first post, anything I overlooked? thanks.

bouwew · September 12, 2020, 9:36am

Did you restart HA Core after installing the integration?
This is not in the first post but is required.

lll.co · September 12, 2020, 1:35pm

I restarted my server, but the problem is still there.

brefra · September 12, 2020, 4:11pm

Are you sure you have selected the correct USB serial device? The most obvious reason to bump into this error messages is when you selected/entered a wrong device path.

lll.co · September 14, 2020, 2:26pm

I have tried a few things, different usb port, a few restarts of the server but nothing works. I know for sure I have the right USB stick. This is the error I see in the logs when I attempt to configure it:

Skip message, received 54 bytes of expected 60 bytes

and:

 Uncaught thread exception 
Traceback (most recent call last):
  File "/usr/local/lib/python3.8/threading.py", line 932, in _bootstrap_inner
    self.run()
  File "/usr/local/lib/python3.8/threading.py", line 870, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/local/lib/python3.8/site-packages/plugwise/stick.py", line 514, in _receive_timeout_loop
    if self._cb_stick_initialized:
AttributeError: 'stick' object has no attribute '_cb_stick_initialized'

brefra · September 14, 2020, 5:58pm

It seems that the first answer to the initialization request from the USB stick is different from what is expected: a message with 54 bytes instead of a message containing 60 bytes. I am curious about the contents of this 54 bytes message.

To investigate this could you collect some debug logging by setting the logging level like below? As it fails at the initialization phase the log will be small.

logger:
  default: warning
  logs:
    custom_components.plugwise_stick: debug
    python-plugwise: debug

The crash (uncaught thread exception) happens while recovering from the unexpected response. I will fix that but it won’t solve your problem as it shouldn’t get to that point.

lll.co · September 14, 2020, 6:26pm

here is the log:

2020-09-14 20:23:18 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for plugwise_stick which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant.
2020-09-14 20:23:45 DEBUG (SyncWorker_2) [python-plugwise] Open USB serial connection to Plugwise Zigbee stick
2020-09-14 20:23:45 DEBUG (SyncWorker_2) [python-plugwise] Open serial port /dev/serial/by-id/usb-FTDI_FT232R_USB_UART_A4003x54-if00-port0
2020-09-14 20:23:45 DEBUG (SyncWorker_2) [python-plugwise] Successfully connected to serial port /dev/serial/by-id/usb-FTDI_FT232R_USB_UART_A4003x54-if00-port0
2020-09-14 20:23:45 DEBUG (SyncWorker_2) [python-plugwise] Starting threads...
2020-09-14 20:23:45 DEBUG (SyncWorker_2) [python-plugwise] All threads started
2020-09-14 20:23:45 DEBUG (SyncWorker_23) [python-plugwise] Send init request to Plugwise Zigbee stick
2020-09-14 20:23:45 DEBUG (send_messages_thread) [python-plugwise] send StickInitRequest using seq_id b'0000'
2020-09-14 20:23:45 DEBUG (serial_writer_thread) [python-plugwise] Sending StickInitRequest to plugwise stick (b'\x05\x05\x03\x03000AB43C\r\n')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Feed data: b'\x05\x05\x03\x030011000D6F00002363C501000D6F00002366A934DAFF5370\r\n\x05\x05\x03\x0300'
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Parse data: b'\x05\x05\x03\x030011000D6F00002363C501000D6F00002366A934DAFF5370\r\n\x05\x05\x03\x0300' 
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message header (b'\x05\x05\x03\x03') in (b'\x05\x05\x03\x030011000D6F00002363C501000D6F00002366A934DAFF5370\r\n\x05\x05\x03\x0300')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Valid message header found at index 0
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message footer (b'\r\n') in (b'\x05\x05\x03\x030011000D6F00002363C501000D6F00002366A934DAFF5370\r\n\x05\x05\x03\x0300')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Valid message footer found at index 52
2020-09-14 20:23:45 ERROR (serial_reader_thread) [python-plugwise] Skip message, received 54 bytes of expected 60 bytes
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Reset parser : b'\x05\x05\x03\x0300'
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Parse data: b'\x05\x05\x03\x0300' 
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message header (b'\x05\x05\x03\x03') in (b'\x05\x05\x03\x0300')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Valid message header found at index 0
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message footer (b'\r\n') in (b'\x05\x05\x03\x0300')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] No valid message footer found yet
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Feed data: b'0000C1AB92\r\n\x83'
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Parse data: b'\x05\x05\x03\x03000000C1AB92\r\n\x83' 
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message header (b'\x05\x05\x03\x03') in (b'\x05\x05\x03\x03000000C1AB92\r\n\x83')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Valid message header found at index 0
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message footer (b'\r\n') in (b'\x05\x05\x03\x03000000C1AB92\r\n\x83')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Valid message footer found at index 16
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Received message b'\x05\x05\x03\x03000000C1AB92\r\n' to small, skip parsing
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Reset parser : b'0000C1AB92\r\n\x83'
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Parse data: b'0000C1AB92\r\n\x83' 
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] Lookup message header (b'\x05\x05\x03\x03') in (b'0000C1AB92\r\n\x83')
2020-09-14 20:23:45 DEBUG (serial_reader_thread) [python-plugwise] No valid message header found yet
2020-09-14 20:23:50 ERROR (receive_timeout_thread) [root] Uncaught thread exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.8/threading.py", line 932, in _bootstrap_inner
    self.run()
  File "/usr/local/lib/python3.8/threading.py", line 870, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/local/lib/python3.8/site-packages/plugwise/stick.py", line 514, in _receive_timeout_loop
    if self._cb_stick_initialized:
AttributeError: 'stick' object has no attribute '_cb_stick_initialized'

brefra · September 15, 2020, 7:21pm

I did some investigation to the response message:

0011000D6F00002363C501000D [Zigbee state missing] 6F00002366A934DA [Zigbee ID missing] FF5370

I’m guessing the Zigbee network information is missing, but I’m not 100% sure yet. From some reverse enginering of the plugwise source software I discovered there could be situations some information in this message is optional, but I have not seen this happen in real life before.

To be sure could you let me know some little more information?

Does the Circle+ module have ID 934DA ?
Is the Circle+ operational (powered) and within reach of the USB-Stick
Does the USB-Stick work using the Windows Source software?

JeeCee · September 15, 2020, 7:44pm

Hi, I just noticed this: I have used my oven in the morning and evening, as can be seen in the power usage graph.
However, in the energy used graph the morning usage is not shown.
How can I/we debug this?

Also, how can I retrieve “total power usage to date”?
Thanks for any help!

jammiejammie · September 18, 2020, 2:05pm

I’ve been running Plugwise-2-py fro a long time now and i’ve made some small modifications to if for myself.

As home assistant only works with present values, I’ve modified the Plugwse-2-py to push straight to influxdb. So in case home assistant is crashing, or a circle is out of range for some time, the data will be recovered as soon as the connection is back. Maybe we can add something like that to this plugin at a later stage.

But first things first, stability.

I wanted to test this integration. But during testing i found that the polling is not consistent.
Using the Plugwise-2-py -> MQTT -> Influxdb I get consistent pols every 10 (+/-1) seconds:

Using the stick plugin (Homeassistant ->Influxdb) i get mixed times:

lll.co · September 18, 2020, 6:30pm

hi there,

My circle+ does NOT have the ID: 934DA
the Circle+ is powered and when plugging in I hear a ‘click’
I have tried using the circle+ with the source software on windows but it gets stuck on linking it to the stick. I’ve waited around 1,5 hours and it’s still not working.