Core: State of ZHA devices reset to default after HA restart

Created on 23 Jan 2018  路  28Comments  路  Source: home-assistant/core

Make sure you are running the latest version of Home Assistant before reporting an issue.

You should only file an issue if you found a bug. Feature and enhancement requests should go in the Feature Requests section of our community forum:

Home Assistant release (hass --version):
0.61.1

Python release (python3 --version):
Python 3.5.4

Component/platform:
zha

Description of problem:
If I restart HA, then the state of my zha components resets back to default. For example if a window was reported as open through the SmartThings multi sensor, after resetting HA it will now be reporting closed, even though the windows is still open. The windows state will stay incorrect until I close and reopen the window.

Expected:
After a HA restart, either restore zha sensors to the previous state before the restart, or poll the devices for the current status.

Problem-relevant configuration.yaml entries and steps to reproduce:
  1. With a zha sensor, change to the non-default state
  2. Restart HA and observe the HA state has reset to default, which is now incorrect with the sensors physical state.
  3. Profit

Traceback (if applicable):

Additional info:

zha
Source
picture ryanwinter

Most helpful comment

@dshokouhi probably because zigpy cache contains stale value. Currently zigpy cache overrides the saved state, but isn't really updated, because IAS devices are not relying on attribute updates.

Try removing update_before_add=True from https://github.com/home-assistant/home-assistant/blob/aa29eeba04a68234a46c298fabef88d3635922f5/homeassistant/components/zha/binary_sensor.py#L77 and let me know if it improves the situation

picture Adminiuga on 5 Feb 2019
👍2

All 28 comments

this pull request should help fix it once its ready

https://github.com/home-assistant/home-assistant/pull/11672

dshokouhi picture dshokouhi on 23 Jan 2018
👍1

Great, so we will hopefully have a fix in 0.62. This is awesome!

ryanwinter picture ryanwinter on 23 Jan 2018

There hasn't been any activity on this issue recently. Due to the high number of incoming GitHub notifications, we have to clean some of the old issues, as many of them have already been resolved with the latest updates.

Please make sure to update to the latest Home Assistant version and check if that solves the issue. Let us know if that works for you by adding a comment :+1:

balloobbot picture balloobbot on 30 Mar 2018

This issue still exists in 0.67.1

ryanwinter picture ryanwinter on 24 Apr 2018

As of 0.69, my Smartthings multisensors default to an open position on restart. I have open and close every device to restore the actual position.

ryanwinter picture ryanwinter on 13 May 2018

my iris contact sensors also revert back to off even if they are actually open so I guess that PR did not help here.

dshokouhi picture dshokouhi on 17 May 2018

@rcloran, are you aware of this issue? Is there anything I can do to provide debug, or perhaps if you can point me to some area of code I can try making some changes to fix this?

I think from a previous thread I saw somewhere, there was a solution in that HA should poll the devices for their status when it comes online.

ryanwinter picture ryanwinter on 21 May 2018

@ryanwinter the PR referenced above should have fixed this. My guess is that the initial read operation is failing when the entity is added to hass. I'll see if I can devise a way to handle that case.

dmulcahey picture dmulcahey on 27 May 2018

I was checking the devices again, I notice that some of the multisensors always initialise to open, and other always to close. Before the PR they were all listed as closed.

ryanwinter picture ryanwinter on 27 May 2018

@ryanwinter I saw that as well on my iris motion sensor...I have to manually set the state to off for it to report correctly. I think I saw a PR coming up to fix aysnc update of binary sensors maybe thats what we are waiting for?

dshokouhi picture dshokouhi on 27 May 2018
👍1

I dont really understand why some of my sensors always come back open, and other closed after a restart.

Even if it just restored the previous state would be preferable.

ryanwinter picture ryanwinter on 28 May 2018

@ryanwinter can you turn the logging up for bellows and zigpy and zha and get me a log so I can take a look?

dmulcahey picture dmulcahey on 28 May 2018

I have connected:

  • 7 ikea tradfri bulbs
  • 1 smartthings motion sensor
  • 2 smartthings outlets
  • 8 smartthing multi sensors
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.appdb] Loading application state from /mnt/homeassistant/hass/zigbee.db
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because profile_id mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.TemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because endpoint list mismatch: dict_keys([1, 2, 3]) {1}
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraTemperatureHumiditySensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraOpenCloseSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because device_type mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Considering <class 'zigpy.quirks.xiaomi.AqaraWaterSensor'>
2018-05-27 22:02:01 DEBUG (MainThread) [zigpy.quirks] Fail because input cluster mismatch on at least one endpoint
2018-05-27 22:02:01 DEBUG (MainThread) [bellows.uart] Sending: b'1ac038bc7e'
2018-05-27 22:02:01 ERROR (MainThread) [homeassistant.setup] Unable to setup dependencies of camera.arlo. Setup failed for dependencies: arlo
2018-05-27 22:02:01 ERROR (MainThread) [homeassistant.setup] Unable to prepare setup for platform camera.arlo: Could not setup all dependencies.
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] RSTACK Version: 2 Reason: RESET_SOFTWARE frame: b'c1020b0a527e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command version
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'004221a850ed2c7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'0142a1a8502805e67f627e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 0 (version) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'7d314321fb582815c3277e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'1243a1fb54fb737e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'224021fb592f15226f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'2340a1fb54c6107e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'334121fb792b15a2d77e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'3441a1fb54d32a7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'444621fb7d5e291514417e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'4546a1fb5435d07e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'554721fb4d2815713f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'5647a1fb54a9ec7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'664421fb513a156dc37e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'6744a1fb54948f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'774521fb4e221542f17e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'7045a1fb5481b57e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'004a21fb450a1565697e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'014aa1fb54e28c7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'7d314b21fb55d515e9a97e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'124ba1fb547eb07e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'224821fb4a2b15f9da7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'2348a1fb5443d37e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'334921fb629e15fdff7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'3449a1fb63105d7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'444e21fb471615579c7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'454ea1fb54b0137e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setConfigurationValue
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'554f21fb4f2c15ded97e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'564fa1fb542c2f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 83 (setConfigurationValue) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command networkInit
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'664c21bff1a47e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'674ca5bf540c847e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 23 (networkInit) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'774cb1b1c437cb7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 25 (stackStatusHandler) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command getNetworkParameters
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'704d21803d167e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'004da180542bd12f9639f36b953bbc9e944127abedce677302c12b837e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 40 (getNetworkParameters) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setPolicy
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'015221fd517a7d38ab7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'1152a1fd54d2147e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 85 (setPolicy) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setPolicy
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'125321fd524b15bf7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'2253a1fd54469c7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 85 (setPolicy) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command setPolicy
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'235021fd542b57417e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'3350a1fd54734b7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 85 (setPolicy) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command getNodeId
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'3451218f5e967e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'4451a18f542a11387e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 39 (getNodeId) received
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Send command getEui64
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'4556218effe67e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Data frame: b'5556a18e840c06b959fb472520ba7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:02 DEBUG (MainThread) [bellows.ezsp] Application frame 38 (getEui64) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'5657219c547364b259b54a25aa1593499c4f26bdec9c2f82fcc63874d87f39a7e81df87c84ffa8d6d5d31f857e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'6657a19c5420d98c7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'6754219c54d08ab259b54a25aa1593499c4c25bdef06988dfcc63874d87f39a7e81df87c84ffa8d6d5d3a7847e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'7754a19c5421785b7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'0754b1f10d5b47fa50954a7e57716ee39c3c5d7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'1754b1f10d5b47fa50954a7e577164e39ce59d7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'2754b1ed542a1593d9944a65aa55927e65e47eda1231658afdc4a0bc7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'3754b197547364b259b54a25aa1592499c4426abed78de7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'7455219c547364b658924a24ab1593499c4d24a0edcd618bfdc67389fc263d87df7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'4055a19c542645207e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'5055b1f10d5b47fa50954a7e57716be39c6b227e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'6055b1f10d5b47fa50954a7e57717ce39c8fd27e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'7055b1ed542e14b459954b65ab55927146e47eda12316393fec1638bc88b7e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Data frame: b'0055b197547364b658924a24ab1593499c4224abed6c487e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:03 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Data frame: b'1055b1ed542a1593d9944a65aa5592307be4dd3412316589fd00277e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Data frame: b'2055b19754d08ab259b54a25aa1592499c4525abed51cd7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'035a219c54d08ab658924a24ab1593499c4a23a0edca618bfdc67389fc263dd09d7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Data frame: b'315aa19c542730c47e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Data frame: b'415ab1ed542e14b459954b65ab55923308e4dd3412316393f9c163659e7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Data frame: b'515ab19754d08ab658924a24ab1593499c4323abed5e887e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:04 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Data frame: b'615ab1ed502a15b459944a2dab55923263f6dd3412316ed700396788fd673fa7fdac7e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:13 DEBUG (MainThread) [zigpy.zdo] [0x9ffa:zdo] ZDO request 0x0006: [65533, 260, [25], []]
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Sending: b'175b219c54d08ab25992ca25aa1593499c4b22ade8ce678bfcc76f9f7e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Data frame: b'725ba19c54240e067e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Data frame: b'025bb19754d08ab25992ca25aa1593499c4022abed895d7e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:13 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:15 ERROR (Dummy-2) [libopenzwave] notif_callback exception
Traceback (most recent call last):
  File "src-lib/libopenzwave/libopenzwave.pyx", line 494, in libopenzwave.notif_callback
IndexError: list index out of range
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Data frame: b'125bb1ed542e14ab59954b65aa55923579e7dd341231698ae5c76283ed6a3fb5ebcdde6e8f18b27e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:15 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] ZCL request 0x0101: [1, 4362, 20, 18, 1]
2018-05-27 22:02:15 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'2258219c54d08ab658924a24ab1593499c4821a8ecc8672be37e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Data frame: b'2358a19c5425c5c17e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Data frame: b'3358b1ed542e14b459954b65ab55923477e7dd3412316283fbcd6389323b7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Data frame: b'4358b19754d08ab658924a24ab1593499c4121abed83e67e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'3559219c545500b6589c4a24ab1593499c4920adecc963f5f8c627127e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Data frame: b'5459a19c543a01937e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:15 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'465e219c54ee69b658924a24ab1593499c462fa8ecc6676dac7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'655ea19c543b1c4a7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'755eb1f12b3fb4ae116ab572a1556dff9c953b7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'055eb1f12b3fb4ae116ab572a1556cff9cf80c7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'155eb1ed542e14b459954b65ab55922763fce3d712316283f5cd638974297e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'255eb19754ee69b658924a24ab1592499c5f2fabed5a607e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'535f219c5458b6b658924a24ab1593499c472ea8ecc7678eac7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'365fa19c5438380c7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'465fb1ed542e14ba59954b65ab55921163f858be12316283facd6789fe09ed7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'565fb197545500b6589c4a24ab1592499c5e20abed79f87e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'665c219c54ce82b6589c4a24ab1593499c442dadecc46375f8c660407e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'665fb1f12689bd7fde6ab572a1556df09cdef87e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'765fb1f12689bd7fde6ab572a1556df19cf3c87e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'075ca19c5439acd37e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'175cb1ed542e14b459954b65ab55924a63f7550812316283f4cd6389fe1dae7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'275cb1975458b6b658924a24ab1592499c5c2eabede4b07e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'735d219c54aac1b658924a24ab1593499c452ca8ecc5675f1b7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'305da19c543e91a87e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'405db1f1b0bd32a0d56ab572a1556df89c63067e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'505db1f1b0bd32a0d56ab572a1556df89c7d077e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'605db1f1d4fe7b06d16ab572a15564e29c8b9c7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'705db1f1d4fe7b06d16ab572a1556de29c0b0c7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'005db1ed542e14b459954b65ab55921761e4a77f12316283f6cd6389fe19d87e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'105db1ed542e14ba59954b65ab55926a61ffc33c12316283f7cd6789fefae67e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'205db19754aac1b658924a24ab1592499c5a2cabedb1547e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Data frame: b'305db19754ce82b6589c4a24ab1592499c5d2dabedcad07e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:16 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:18 DEBUG (MainThread) [bellows.uart] Data frame: b'405db1ed542e14ab59954b65aa55923770e7dd341231698ae4c76283ed6a3fb5ebcdde6e8fd3b17e'
2018-05-27 22:02:18 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:18 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:18 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] ZCL request 0x0101: [1, 4362, 20, 18, 1]
2018-05-27 22:02:18 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:20 DEBUG (MainThread) [bellows.uart] Data frame: b'505db1ed542e14ab59954b65aa55923669e7dd341231698ae7c76283ed6a3fb5ebcdde6e8f50de7e'
2018-05-27 22:02:20 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:20 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:20 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] ZCL request 0x0101: [1, 4362, 20, 18, 1]
2018-05-27 22:02:20 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:23 DEBUG (MainThread) [bellows.uart] Data frame: b'605db1ed542e14ab59954b65aa5592c96ae7dd341231698ae6c76283ed6a3fb5ebcdde6e8f43e87e'
2018-05-27 22:02:23 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:23 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:23 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] ZCL request 0x0101: [1, 4362, 20, 18, 1]
2018-05-27 22:02:23 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:26 DEBUG (MainThread) [bellows.uart] Data frame: b'705db1ed542e14ab59954b65aa5592c86be4dd341231698ae1c76283ed6a3fb5ebcdde6e8fda447e'
2018-05-27 22:02:26 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:26 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:26 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] ZCL request 0x0101: [1, 4362, 20, 18, 1]
2018-05-27 22:02:26 DEBUG (MainThread) [zigpy.zcl] [0x9ffa:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Data frame: b'005db1ed502a15b459944a2dab55929d63fe879212316ead00396788fd673fa7397a7e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:27 DEBUG (MainThread) [zigpy.zdo] [0x39a0:zdo] ZDO request 0x0006: [65533, 260, [25], []]
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Sending: b'0162219c548a2cb25992ca25aa1593499c422bade1ce678bfcc7863a7e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Data frame: b'1162a19c543f98367e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Data frame: b'2162b197548a2cb25992ca25aa1592499c5b2babed1dc97e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Data frame: b'3162b1ed542e14b05d954b65ab559289639fbb6912316f93cdcc6389d5783644a37e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2018-05-27 22:02:27 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:27 DEBUG (MainThread) [zigpy.zcl] [0xc29c:1:0x0402] ZCL request 0x000a: [[<Attribute attrid=0 value=<zigpy.zcl.foundation.TypeValue object at 0x80d7b8c18>>]]
2018-05-27 22:02:27 DEBUG (MainThread) [zigpy.zcl] [0xc29c:1:0x0402] Attribute report received: 0=2310
2018-05-27 22:02:27 DEBUG (MainThread) [homeassistant.components.sensor.zha] Attribute updated: <Entity None: unknown> 0 2310
2018-05-27 22:02:29 DEBUG (MainThread) [bellows.uart] Data frame: b'4162b1ed542e14ab59954b65ab55929c6ee487921231698aa8c76283ed6f3fbcebcdde6e8f5acb7e'
2018-05-27 22:02:29 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2018-05-27 22:02:29 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:29 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] ZCL request 0x0101: [1, 4362, 17, 27, 1]
2018-05-27 22:02:29 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:32 DEBUG (MainThread) [bellows.uart] Data frame: b'5162b1ed542e14ab59954b65ab55929f4ae287921231698aabc76283ed6f3fbcebcdde6e8f41f37e'
2018-05-27 22:02:32 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2018-05-27 22:02:32 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:32 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] ZCL request 0x0101: [1, 4362, 17, 27, 1]
2018-05-27 22:02:32 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:35 DEBUG (MainThread) [bellows.uart] Data frame: b'6162b1ed542e14ab59954b65ab55929e64e787921231698aaac76283ed6f3fbcebcdde6e8f5b4c7e'
2018-05-27 22:02:35 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2018-05-27 22:02:35 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:35 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] ZCL request 0x0101: [1, 4362, 17, 27, 1]
2018-05-27 22:02:35 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:37 DEBUG (MainThread) [bellows.uart] Data frame: b'7162b1ed542e14ab59954b65ab55929153e687921231698aa5c76283ed6f3fbcebcdde6e8fdf8e7e'
2018-05-27 22:02:37 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2018-05-27 22:02:37 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:37 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] ZCL request 0x0101: [1, 4362, 17, 27, 1]
2018-05-27 22:02:37 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] No handler for cluster command 1
2018-05-27 22:02:40 DEBUG (MainThread) [bellows.uart] Data frame: b'0162b1ed542e14ab59954b65ab55929072e787921231698aa4c76283ed6f3fbcebcdde6e8f20357e'
2018-05-27 22:02:40 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2018-05-27 22:02:40 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:02:40 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] ZCL request 0x0101: [1, 4362, 17, 27, 1]
2018-05-27 22:02:40 DEBUG (MainThread) [zigpy.zcl] [0x39a0:1:0x0019] No handler for cluster command 1
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.uart] Data frame: b'1162b1f187a4710e51954a7e57716df09d3c841d757e'
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.uart] Data frame: b'2162b1ed542e14b05d954b65ab5592bf63f7f42512316f938bcc6389d57037a332657e'
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2018-05-27 22:04:00 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2018-05-27 22:04:00 DEBUG (MainThread) [zigpy.zcl] [0x8ed3:1:0x0402] ZCL request 0x000a: [[<Attribute attrid=0 value=<zigpy.zcl.foundation.TypeValue object at 0x812ca84a8>>]]
2018-05-27 22:04:00 DEBUG (MainThread) [zigpy.zcl] [0x8ed3:1:0x0402] Attribute report received: 0=2062
2018-05-27 22:04:00 DEBUG (MainThread) [homeassistant.components.sensor.zha] Attribute updated: <Entity None: unknown> 0 2062
ryanwinter picture ryanwinter on 28 May 2018

Just an update: I鈥檓 going to try to look into this over the next couple of evenings. I bought a few devices for my test / dev setup and they came in last evening... hopefully have news soon.

dmulcahey picture dmulcahey on 30 May 2018
👍1

Also just noticed that in 0.70, the behaviour is different again. My smartthing multi sensors appear to mostly default to closed, although occasionally they default to the previous state.

My ikea light bulbs, the older ones appear to be in the previous state, the newer ones default to on.

ryanwinter picture ryanwinter on 31 May 2018

My Iris Contact Sensors second gen (centralite rebrands) still report as off after restart even though they are open and should be on.

I noticed that in 0.70 the temperature readings from the same sensors are no longer cleared out until the next update after a restart. The front end now retains the last reading instead of unknown so its definitely showing what it previously had. Maybe similar code needs to be used to restore the real state? I am assuming it is this PR that fixed it for my sensors: https://github.com/home-assistant/home-assistant/pull/14357

dshokouhi picture dshokouhi on 31 May 2018
👍1

So I have a potential fix for lights... do any of you have lights connected?

dmulcahey picture dmulcahey on 1 Jun 2018

I just spotted this comment @dmulcahey, I have a bunch of ikea light bulbs attached.

ryanwinter picture ryanwinter on 20 Jun 2018

@ryanwinter it didn鈥檛 work as expected so you didn鈥檛 miss anything!

dmulcahey picture dmulcahey on 20 Jun 2018

16424 is probably related to this.

Looks like the ZHA cache doesn't always update or save the correct information, and if you don't use the cache when zha first starts up it sends too many messages to the zigbee network and gets an error back.

cgarwood picture cgarwood on 17 Sep 2018
👍1

I have around 12 zha devices, so I can totally understand why too many messages at startup could be causing a failure.

ryanwinter picture ryanwinter on 18 Sep 2018

Would it be possible to just restore the previous state by default after a restart?

ryanwinter picture ryanwinter on 20 Nov 2018

any updates on this? None of my zigbee devices show correct state after restart. They all show as on and i have to go look what is actually on/off and correct it manually.

damusmf picture damusmf on 26 Dec 2018

@ryanwinter does the issue still exist with 0.86.4?

Adminiuga picture Adminiuga on 5 Feb 2019

@Adminiuga personally I still see this issue but things seem to have been fixed to an extent. Now my issue is that some devices are out of sync after a HA service restart. So they come back as on even though they were last off although that is different than this bug because before they were always off on a restart.

dshokouhi picture dshokouhi on 5 Feb 2019

@dshokouhi probably because zigpy cache contains stale value. Currently zigpy cache overrides the saved state, but isn't really updated, because IAS devices are not relying on attribute updates.

Try removing update_before_add=True from https://github.com/home-assistant/home-assistant/blob/aa29eeba04a68234a46c298fabef88d3635922f5/homeassistant/components/zha/binary_sensor.py#L77 and let me know if it improves the situation

Adminiuga picture Adminiuga on 5 Feb 2019
👍2

@Adminiuga thank you! that solved it for me :) I changed line 77 to async_add_entities(entities) and restarted and all the states on my binary sensors are correct on and off

dshokouhi picture dshokouhi on 5 Feb 2019
🎉1

should be completely fixed w/ .88

dmulcahey picture dmulcahey on 20 Feb 2019
Was this page helpful?
0 / 5 - 0 ratings

Related issues

kirichkov picture kirichkov  路  3Comments
sogeniusio picture sogeniusio  路  3Comments
neonandu picture neonandu  路  3Comments
sibbl picture sibbl  路  3Comments
ofuangka picture ofuangka  路  3Comments