xiaomi devices are unavailable periodically and motion sensors are not working

[prashantzarkar]

Home Assistant release with the issue: Home Assistant 0.73.1

Last working Home Assistant release (if known): N/A new to HA and having this problem

Operating environment (Hass.io/Docker/Windows/etc.): Hass.io on raspberry pi 3B

Component/platform: xiaomi_aqara(https://www.home-assistant.io/components/xiaomi_aqara/)

Description of problem: I have added xiaomi_aqara and can see all my xiaomi devices (door sensor, motion sensors and temp sensors) however I have the following two problems 1) all the devices show status as unavailable until I restart HA 2) Upon restart, all the devices are available however motion sensors don't show any response to motion detected and history tab show as clear all the time.

Problem-relevant configuration.yaml entries and (fill out even if it seems unimportant): configurations.yaml details

xiaomi_aqara:
  discovery_retry: 5
  gateways:
  - host: 192.168.0.25
    mac: 34:ce:00:**:**:b8
    key: b5a9faaa********

Traceback (if applicable):

I have added the additional log however don't see any trace

2018-07-15 20:56:44 WARNING (MainThread) [homeassistant.components.http] You have been advised to set http.api_password.
2018-07-15 20:56:54 ERROR (MainThread) [homeassistant.components.device_tracker] Unable to load /config/known_devices.yaml: Config file not found: /config/known_devices.yaml
2018-07-15 20:56:54 DEBUG (MainThread) [homeassistant.components.homekit] Begin setup HomeKit
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: Name to Home Assistant Bridge
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: SerialNumber to default
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: FirmwareRevision to 0.73.1
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: Manufacturer to Home Assistant
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: Model to Bridge
2018-07-15 20:56:56 DEBUG (SyncWorker_2) [pyhap.characteristic] set_value: SerialNumber to homekit.bridge
2018-07-15 20:57:03 WARNING (MainThread) [homeassistant.setup] Setup of config is taking over 10 seconds.
2018-07-15 20:57:17 WARNING (MainThread) [homeassistant.components.sensor] Setup of platform ring is taking over 10 seconds.
2018-07-15 21:57:02 ERROR (MainThread) [homeassistant.components.updater] Got unexpected response: {'errorMessage': 'RequestId: 2fab4bb3-8826-11e8-a109-17c7755a6d9f Process exited before completing request'}
2018-07-15 21:57:19 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-15 22:57:17 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-15 23:35:17 ERROR (SyncWorker_9) [homeassistant.components.light.yeelight] Unable to update bulb status: Bulb closed the connection.
2018-07-15 23:36:17 ERROR (SyncWorker_7) [homeassistant.components.light.yeelight] Unable to update bulb status: Bulb closed the connection.
2018-07-16 00:22:14 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 01:27:23 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 02:39:53 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 03:27:25 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.ring_front_door_last_ding is taking over 10 seconds
2018-07-16 04:04:31 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 05:07:05 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.ring_front_door_last_activity is taking over 10 seconds
2018-07-16 05:07:26 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 05:07:56 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 05:08:27 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 05:08:58 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 05:10:33 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 06:49:04 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 06:50:51 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.ring_front_door_last_ding is taking over 10 seconds
2018-07-16 07:59:24 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 09:09:39 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 10:19:32 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 11:34:21 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 12:39:13 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17
2018-07-16 12:45:00 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.ring_front_door_last_activity is taking over 10 seconds
2018-07-16 12:45:18 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 12:45:49 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 12:46:20 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 12:46:51 WARNING (MainThread) [homeassistant.components.sensor] Updating ring sensor took longer than the scheduled update interval 0:00:30
2018-07-16 13:17:48 ERROR (SyncWorker_12) [homeassistant.components.light.yeelight] Unable to update bulb status: Bulb closed the connection.
2018-07-16 13:17:48 ERROR (SyncWorker_17) [homeassistant.components.light.yeelight] Unable to update bulb status: Bulb closed the connection.
2018-07-16 13:17:48 ERROR (SyncWorker_4) [homeassistant.components.light.yeelight] Unable to update bulb status: Bulb closed the connection.
2018-07-16 13:19:42 ERROR (MainThread) [homeassistant.components.light.hue] Unable to reach bridge 192.168.1.17

Additional information:

[Danielhiversen]

https://www.home-assistant.io/components/xiaomi_aqara/#connection-problem

Ensure your router supports multicast as this is a requirement of the Xiaomi Gateway.

[prashantzarkar]

@Danielhiversen - thanks for your comment, I do have multicast support enabled on my router (I have Ubiquiti USG and AC pro set up). P.S I've gone through the troubleshooting section and my problem is not one of them.

Here is my latest log this is what I get when I restart the HA which means Xiaomi gateway is starting normally however when devices shows unavailable, there is no log

2018-07-16 21:11:56 INFO (SyncWorker_7) [xiaomi_gateway] Xiaomi Gateway 34ce0091d6b8 configured at IP 192.168.0.25:9898
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"34ce0091d6b8"}'
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'gateway', 'sid': '34ce0091d6b8', 'short_id': 0, 'data': '{"rgb":0,"illumination":1292,"proto_version":"1.1.2"}'}
2018-07-16 21:11:56 INFO (SyncWorker_7) [xiaomi_gateway] Discovering Xiaomi Devices
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd" : "get_id_list"}'
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'get_id_list_ack', 'sid': '34ce0091d6b8', 'token': 'wcEcPSHyx85j2yJg', 'data': '["158d0001e17391","158d0001b1a664","158d0001aabc60","158d0001da433e","158d0001c2fdf8","158d0001c2ad1c","158d0001fd3532","158d0001e15f3a","158d0001e07fdf","158d0001d86e69","158d0001b76fd9"]'}
2018-07-16 21:11:56 INFO (SyncWorker_7) [xiaomi_gateway] Found 12 devices
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001e17391"}'
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'plug', 'sid': '158d0001e17391', 'short_id': 57720, 'data': '{"voltage":3600,"status":"unknown","inuse":"0"}'}
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001e17391, plug as: switch
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b1a664"}'
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'motion', 'sid': '158d0001b1a664', 'short_id': 31516, 'data': '{"voltage":3035}'}
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001b1a664, motion as: binary_sensor
2018-07-16 21:11:56 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001aabc60"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'magnet', 'sid': '158d0001aabc60', 'short_id': 65016, 'data': '{"voltage":2995,"status":"close"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001aabc60, magnet as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001da433e"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'switch', 'sid': '158d0001da433e', 'short_id': 51936, 'data': '{"voltage":3022}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001da433e, switch as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001c2fdf8"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'magnet', 'sid': '158d0001c2fdf8', 'short_id': 29769, 'data': '{"voltage":3005,"status":"close"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001c2fdf8, magnet as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001c2ad1c"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'sensor_ht', 'sid': '158d0001c2ad1c', 'short_id': 44048, 'data': '{"voltage":3025,"temperature":"1638","humidity":"4848"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001c2ad1c, sensor_ht as: sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001fd3532"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'sensor_ht', 'sid': '158d0001fd3532', 'short_id': 4291, 'data': '{"voltage":2985,"temperature":"1854","humidity":"4468"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001fd3532, sensor_ht as: sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001e15f3a"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'sid': '158d0001e15f3a', 'short_id': 38656, 'data': '{"voltage":3015,"lux":"16"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001e15f3a, sensor_motion.aq2 as: sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001e15f3a, sensor_motion.aq2 as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001e07fdf"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'sid': '158d0001e07fdf', 'short_id': 35311, 'data': '{"voltage":3025,"lux":"6"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001e07fdf, sensor_motion.aq2 as: sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001e07fdf, sensor_motion.aq2 as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001d86e69"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'smoke', 'sid': '158d0001d86e69', 'short_id': 3388, 'data': '{"voltage":3055,"alarm":"0"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001d86e69, smoke as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b76fd9"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'magnet', 'sid': '158d0001b76fd9', 'short_id': 62350, 'data': '{"voltage":2975,"status":"close"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 158d0001b76fd9, magnet as: binary_sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"34ce0091d6b8"}'
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] _send_cmd resp << {'cmd': 'read_ack', 'model': 'gateway', 'sid': '34ce0091d6b8', 'short_id': 0, 'data': '{"rgb":0,"illumination":1292,"proto_version":"1.1.2"}'}
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 34ce0091d6b8, gateway as: sensor
2018-07-16 21:11:57 DEBUG (SyncWorker_7) [xiaomi_gateway] Registering device 34ce0091d6b8, gateway as: light
2018-07-16 21:12:02 DEBUG (MainThread) [homeassistant.components.homekit] Begin setup HomeKit
2018-07-16 21:12:02 INFO (SyncWorker_7) [xiaomi_gateway] Gateway discovery finished in 5 seconds
2018-07-16 21:12:02 INFO (SyncWorker_7) [xiaomi_gateway] Creating Multicast Socket
2018-07-16 21:12:03 WARNING (MainThread) [homeassistant.setup] Setup of config is taking over 10 seconds.

[balloobbot]

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:

[barrerajl]

I have the exact same problems. Suddenly sensors are unavailable and aqara motion sensor does not get change messages. Hassio and HA 82.1

[prashantzarkar]

My problem got resolved. In my case, the root cause was, raspberry pi was on wired network and xiaomi was on wifi. When I moved my Pi to wifi, problem disappeared.

Thanks, Prashant

On 25 Nov 2018, at 11:42 am, barrerajl notifications@github.com wrote:

I have the exact same problems. Suddenly sensors are unavailable and aqara motion sensor does not get change messages.

— You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or mute the thread.

[barrerajl]

My problem got resolved. In my case, the root cause was, raspberry pi was on wired network and xiaomi was on wifi. When I moved my Pi to wifi, problem disappeared. Thanks, Prashant … On 25 Nov 2018, at 11:42 am, barrerajl @.***> wrote: I have the exact same problems. Suddenly sensors are unavailable and aqara motion sensor does not get change messages. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or mute the thread.

Wow I've got the same configuration :-1:

[barrerajl]

Looking into the home router, changed IGMP-Basic Configuration from Proxy (also tried snooping) to disable. And now it seems everything is working.

[syssi]

Closing this because it's a network problem (unstable multicast capabilities).