search

home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
72.42k stars 30.3k forks source link

Xiaomi Wireless WIFI Socket vibrate state since HA 0.80.0 #17422

Closed galoz11 closed 5 years ago

galoz11 commented 6 years ago

soc Home Assistant release with the issue: HA 0.80.0

Last working Home Assistant release: 0.79.3

Operating environment (Hass.io/Docker/Windows/etc.): raspberry pi virtual env with HA

Component/platform: Xiaomi Gateway (Aqara)

Description of problem: Xiaomi Wireless WIFI Socket vibrate state since HA 0.80.0. i have two pi machine, the one that was upgrade to 0.80.0 make the power switch vibrate and change states rapidly. nothing in the logs. (i shut down 0.80.0 machine and try the 0.79.3 and the problem gone)

Problem-relevant configuration.yaml entries and (fill out even if it seems unimportant): no problem there

Additional information:

PaulAnnekov commented 6 years ago
  1. Add the following configuration: 
    logger:
logs:
xiaomi_gateway: debug
homeassistant.components.xiaomi_aqara: debug
  2. Restart HA.
  3. Click on a switch in UI.
  4. Copy-paste HA logs here.
galoz11 commented 5 years ago

edit because the file was too big:

logger:
  default: critical
  logs:
    xiaomi_gateway: debug
    homeassistant.components.xiaomi_aqara: debug
2018-10-14 15:02:43 DEBUG (Thread-8) [homeassistant.components.xiaomi_aqara] Expecting 1 gateways
2018-10-14 15:02:43 INFO (Thread-8) [homeassistant.components.xiaomi_aqara] Discovering Xiaomi Gateways (Try 1)
2018-10-14 15:02:43 INFO (Thread-8) [xiaomi_gateway] Xiaomi Gateway 7811dcb7a6d0 found at IP 192.168.1.80
2018-10-14 15:02:43 INFO (Thread-8) [xiaomi_gateway] Discovering Xiaomi Devices
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd" : "get_id_list"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'token': 'IBPvriOObiwdyTdE', 'sid': '7811dcb7a6d0', 'cmd': 'get_id_list_ack', 'data': '["158d0002010cb4","158d00022edfcb","158d00022cb3c6","158d0002006bf0","158d000200cba8","158d0001b96d0f","158d0001b9483a","158d0001fa3234","158d000200decd","158d000200e08a","158d000200e333","158d000237e98a","158d000238abea","158d0001a69623","158d000290890e","158d00028c8148"]'}
2018-10-14 15:02:43 INFO (Thread-8) [xiaomi_gateway] Found 17 devices
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0002010cb4"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'switch', 'sid': '158d0002010cb4', 'short_id': 15864, 'cmd': 'read_ack', 'data': '{"voltage":3052}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0002010cb4, switch as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00022edfcb"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': '86sw2', 'sid': '158d00022edfcb', 'short_id': 47853, 'cmd': 'read_ack', 'data': '{"voltage":3025}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d00022edfcb, 86sw2 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00022cb3c6"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'weather.v1', 'sid': '158d00022cb3c6', 'short_id': 65272, 'cmd': 'read_ack', 'data': '{"voltage":2985,"temperature":"2790","humidity":"4893","pressure":"100677"}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d00022cb3c6, weather.v1 as: sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0002006bf0"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_motion.aq2', 'sid': '158d0002006bf0', 'short_id': 61899, 'cmd': 'read_ack', 'data': '{"voltage":3045,"lux":"7"}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0002006bf0, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0002006bf0, sensor_motion.aq2 as: sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200cba8"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_motion.aq2', 'sid': '158d000200cba8', 'short_id': 20159, 'cmd': 'read_ack', 'data': '{"voltage":3025,"lux":"204"}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200cba8, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200cba8, sensor_motion.aq2 as: sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b96d0f"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_switch.aq3', 'sid': '158d0001b96d0f', 'short_id': 9151, 'cmd': 'read_ack', 'data': '{"voltage":3005}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0001b96d0f, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b9483a"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_switch.aq3', 'sid': '158d0001b9483a', 'short_id': 45843, 'cmd': 'read_ack', 'data': '{"voltage":3015}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0001b9483a, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001fa3234"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'magnet', 'sid': '158d0001fa3234', 'short_id': 57763, 'cmd': 'read_ack', 'data': '{"voltage":3025,"status":"close"}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0001fa3234, magnet as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200decd"}'
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_motion.aq2', 'sid': '158d000200decd', 'short_id': 59883, 'cmd': 'read_ack', 'data': '{"voltage":3015,"lux":"584"}'}
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200decd, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200decd, sensor_motion.aq2 as: sensor
2018-10-14 15:02:43 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200e08a"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_motion.aq2', 'sid': '158d000200e08a', 'short_id': 6239, 'cmd': 'read_ack', 'data': '{"voltage":3045}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200e08a, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200e08a, sensor_motion.aq2 as: sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200e333"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_motion.aq2', 'sid': '158d000200e333', 'short_id': 28960, 'cmd': 'read_ack', 'data': '{"voltage":3045,"lux":"65"}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200e333, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000200e333, sensor_motion.aq2 as: sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000237e98a"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': '86sw2', 'sid': '158d000237e98a', 'short_id': 34485, 'cmd': 'read_ack', 'data': '{"voltage":3055}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000237e98a, 86sw2 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000238abea"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': '86sw2', 'sid': '158d000238abea', 'short_id': 44667, 'cmd': 'read_ack', 'data': '{"voltage":3025}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000238abea, 86sw2 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001a69623"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d0001a69623, plug as: switch
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000290890e"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_switch.aq3', 'sid': '158d000290890e', 'short_id': 64714, 'cmd': 'read_ack', 'data': '{"voltage":3035}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d000290890e, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00028c8148"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'sensor_switch.aq3', 'sid': '158d00028c8148', 'short_id': 63027, 'cmd': 'read_ack', 'data': '{"voltage":3025}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 158d00028c8148, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"7811dcb7a6d0"}'
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] _send_cmd resp << {'model': 'gateway', 'sid': '7811dcb7a6d0', 'short_id': 0, 'cmd': 'read_ack', 'data': '{"rgb":0,"illumination":1023,"proto_version":"1.1.2"}'}
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 7811dcb7a6d0, gateway as: light
2018-10-14 15:02:44 DEBUG (Thread-8) [xiaomi_gateway] Registering device 7811dcb7a6d0, gateway as: sensor
2018-10-14 15:02:49 INFO (Thread-8) [xiaomi_gateway] Gateway discovery finished in 5 seconds
2018-10-14 15:02:49 INFO (Thread-8) [xiaomi_gateway] Creating Multicast Socket
2018-10-14 15:02:49 DEBUG (Thread-8) [homeassistant.components.xiaomi_aqara] Gateways discovered. Listening for broadcasts
2018-10-14 15:02:57 DEBUG (Thread-24) [xiaomi_gateway] MCAST (heartbeat) << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'heartbeat', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:02:57 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: on>: {'load_power': '0.00', 'inuse': '0', 'voltage': 3600, 'power_consumed': '10637', 'status': 'on'}
2018-10-14 15:03:20 DEBUG (Thread-9) [xiaomi_gateway] _send_cmd >> b'{ "cmd":"read","sid":"158d0001a69623"}'
2018-10-14 15:03:20 DEBUG (Thread-9) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:20 DEBUG (Thread-9) [xiaomi_gateway] read_ack << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:20 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: on>: {'load_power': '0.00', 'inuse': '0', 'voltage': 3600, 'power_consumed': '10637', 'status': 'on'}
2018-10-14 15:03:38 DEBUG (Thread-3) [xiaomi_gateway] _send_cmd >> b'{"sid": "158d0001a69623", "cmd": "write", "data": {"key": "9470b8130d7bf715e77e6356a64c6be3", "status": "off"}}'
2018-10-14 15:03:38 DEBUG (Thread-3) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'write_ack', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:38 DEBUG (Thread-3) [xiaomi_gateway] write_ack << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'write_ack', 'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:38 DEBUG (Thread-2) [xiaomi_gateway] _send_cmd >> b'{ "cmd":"read","sid":"158d0001a69623"}'
2018-10-14 15:03:38 DEBUG (Thread-2) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"unknown","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:38 DEBUG (Thread-2) [xiaomi_gateway] read_ack << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"unknown","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:38 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: off>: {'load_power': '0.00', 'inuse': '0', 'voltage': 3600, 'power_consumed': '10637', 'status': 'unknown'}
2018-10-14 15:03:38 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'report', 'data': '{"status":"off"}'}
2018-10-14 15:03:38 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: off>: {'status': 'off'}
2018-10-14 15:03:39 DEBUG (Thread-5) [xiaomi_gateway] _send_cmd >> b'{"sid": "158d0001a69623", "cmd": "write", "data": {"key": "9470b8130d7bf715e77e6356a64c6be3", "status": "on"}}'
2018-10-14 15:03:39 DEBUG (Thread-5) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'write_ack', 'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:39 DEBUG (Thread-5) [xiaomi_gateway] write_ack << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'write_ack', 'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:39 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{ "cmd":"read","sid":"158d0001a69623"}'
2018-10-14 15:03:39 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"unknown","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:39 DEBUG (Thread-12) [xiaomi_gateway] read_ack << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'read_ack', 'data': '{"voltage":3600,"status":"unknown","inuse":"0","power_consumed":"10637","load_power":"0.00"}'}
2018-10-14 15:03:39 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: on>: {'load_power': '0.00', 'inuse': '0', 'voltage': 3600, 'power_consumed': '10637', 'status': 'unknown'}
2018-10-14 15:03:39 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'model': 'plug', 'sid': '158d0001a69623', 'short_id': 2365, 'cmd': 'report', 'data': '{"status":"on"}'}
2018-10-14 15:03:39 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: off>: {'status': 'on'}
galoz11 commented 5 years ago

i hope i did paste ok.. do you need the whole file @PaulAnnekov ?

edit: i see some ,"status":"unknown" in the log

galoz11 commented 5 years ago

Hi again, for comparison purposes, i downgrad HA (pip3 install homeassistant==0.79.3)

and the problem gone, here is the log for 0.79.3

2018-10-14 15:22:28 DEBUG (Thread-12) [homeassistant.components.xiaomi_aqara] Expecting 1 gateways
2018-10-14 15:22:28 INFO (Thread-12) [homeassistant.components.xiaomi_aqara] Discovering Xiaomi Gateways (Try 1)
2018-10-14 15:22:28 INFO (Thread-12) [xiaomi_gateway] Xiaomi Gateway 7811dcb7a6d0 found at IP 192.168.1.80
2018-10-14 15:22:28 INFO (Thread-12) [xiaomi_gateway] Discovering Xiaomi Devices
2018-10-14 15:22:28 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd" : "get_id_list"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '["158d0002010cb4","158d00022edfcb","158d00022cb3c6","158d0002006bf0","158d000200cba8","158d0001b96d0f","158d0001b9483a","158d0001fa3234","158d000200decd","158d000200e08a","158d000200e333","158d000237e98a","158d000238abea","158d0001a69623","158d000290890e","158d00028c8148"]', 'cmd': 'get_id_list_ack', 'sid': '7811dcb7a6d0', 'token': '5jPKZqA6z0js2inZ'}
2018-10-14 15:22:29 INFO (Thread-12) [xiaomi_gateway] Found 17 devices
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0002010cb4"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3052}', 'sid': '158d0002010cb4', 'cmd': 'read_ack', 'model': 'switch', 'short_id': 15864}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0002010cb4, switch as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00022edfcb"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3025}', 'sid': '158d00022edfcb', 'cmd': 'read_ack', 'model': '86sw2', 'short_id': 47853}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d00022edfcb, 86sw2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00022cb3c6"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":2985,"temperature":"2790","humidity":"4893","pressure":"100677"}', 'sid': '158d00022cb3c6', 'cmd': 'read_ack', 'model': 'weather.v1', 'short_id': 65272}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d00022cb3c6, weather.v1 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0002006bf0"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3045,"lux":"7"}', 'sid': '158d0002006bf0', 'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'short_id': 61899}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0002006bf0, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0002006bf0, sensor_motion.aq2 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200cba8"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3025,"lux":"204"}', 'sid': '158d000200cba8', 'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'short_id': 20159}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200cba8, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200cba8, sensor_motion.aq2 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b96d0f"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3005}', 'sid': '158d0001b96d0f', 'cmd': 'read_ack', 'model': 'sensor_switch.aq3', 'short_id': 9151}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0001b96d0f, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001b9483a"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3015}', 'sid': '158d0001b9483a', 'cmd': 'read_ack', 'model': 'sensor_switch.aq3', 'short_id': 45843}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0001b9483a, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001fa3234"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3025,"status":"close"}', 'sid': '158d0001fa3234', 'cmd': 'read_ack', 'model': 'magnet', 'short_id': 57763}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0001fa3234, magnet as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200decd"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3015,"lux":"587"}', 'sid': '158d000200decd', 'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'short_id': 59883}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200decd, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200decd, sensor_motion.aq2 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200e08a"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3045}', 'sid': '158d000200e08a', 'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'short_id': 6239}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200e08a, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200e08a, sensor_motion.aq2 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000200e333"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3045,"lux":"65"}', 'sid': '158d000200e333', 'cmd': 'read_ack', 'model': 'sensor_motion.aq2', 'short_id': 28960}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200e333, sensor_motion.aq2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000200e333, sensor_motion.aq2 as: sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000237e98a"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3055}', 'sid': '158d000237e98a', 'cmd': 'read_ack', 'model': '86sw2', 'short_id': 34485}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000237e98a, 86sw2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000238abea"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3025}', 'sid': '158d000238abea', 'cmd': 'read_ack', 'model': '86sw2', 'short_id': 44667}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000238abea, 86sw2 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d0001a69623"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'read_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d0001a69623, plug as: switch
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d000290890e"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3035}', 'sid': '158d000290890e', 'cmd': 'read_ack', 'model': 'sensor_switch.aq3', 'short_id': 64714}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d000290890e, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"158d00028c8148"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3025}', 'sid': '158d00028c8148', 'cmd': 'read_ack', 'model': 'sensor_switch.aq3', 'short_id': 63027}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 158d00028c8148, sensor_switch.aq3 as: binary_sensor
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"cmd":"read","sid":"7811dcb7a6d0"}'
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"rgb":0,"illumination":1029,"proto_version":"1.1.2"}', 'sid': '7811dcb7a6d0', 'cmd': 'read_ack', 'model': 'gateway', 'short_id': 0}
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 7811dcb7a6d0, gateway as: light
2018-10-14 15:22:29 DEBUG (Thread-12) [xiaomi_gateway] Registering device 7811dcb7a6d0, gateway as: sensor
2018-10-14 15:22:34 INFO (Thread-12) [xiaomi_gateway] Gateway discovery finished in 5 seconds
2018-10-14 15:22:34 INFO (Thread-12) [xiaomi_gateway] Creating Multicast Socket
2018-10-14 15:22:34 DEBUG (Thread-12) [homeassistant.components.xiaomi_aqara] Gateways discovered. Listening for broadcasts
2018-10-14 15:22:46 DEBUG (Thread-16) [xiaomi_gateway] _send_cmd >> b'{"data": {"key": "f37026df75e72d123f5587cec1481c5d", "status": "off"}, "cmd": "write", "sid": "158d0001a69623"}'
2018-10-14 15:22:46 DEBUG (Thread-16) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:46 DEBUG (Thread-16) [xiaomi_gateway] write_ack << {'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:46 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'data': '{"status":"off"}', 'sid': '158d0001a69623', 'cmd': 'report', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:46 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: off>: {'status': 'off'}
2018-10-14 15:22:47 DEBUG (Thread-7) [xiaomi_gateway] _send_cmd >> b'{"data": {"key": "f37026df75e72d123f5587cec1481c5d", "status": "on"}, "cmd": "write", "sid": "158d0001a69623"}'
2018-10-14 15:22:47 DEBUG (Thread-7) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:47 DEBUG (Thread-7) [xiaomi_gateway] write_ack << {'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:47 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'data': '{"status":"on"}', 'sid': '158d0001a69623', 'cmd': 'report', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:47 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: on>: {'status': 'on'}
2018-10-14 15:22:49 DEBUG (Thread-6) [xiaomi_gateway] _send_cmd >> b'{"data": {"key": "f3b36cefdb2b354d759cf12981c8fdf0", "status": "off"}, "cmd": "write", "sid": "158d0001a69623"}'
2018-10-14 15:22:49 DEBUG (Thread-6) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:49 DEBUG (Thread-6) [xiaomi_gateway] write_ack << {'data': '{"voltage":3600,"status":"on","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:49 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'data': '{"status":"off"}', 'sid': '158d0001a69623', 'cmd': 'report', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:49 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: off>: {'status': 'off'}
2018-10-14 15:22:50 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd >> b'{"data": {"key": "f3b36cefdb2b354d759cf12981c8fdf0", "status": "on"}, "cmd": "write", "sid": "158d0001a69623"}'
2018-10-14 15:22:50 DEBUG (Thread-12) [xiaomi_gateway] _send_cmd resp << {'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:50 DEBUG (Thread-12) [xiaomi_gateway] write_ack << {'data': '{"voltage":3600,"status":"off","inuse":"0","power_consumed":"10637","load_power":"0.00"}', 'sid': '158d0001a69623', 'cmd': 'write_ack', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:51 DEBUG (Thread-24) [xiaomi_gateway] MCAST (report) << {'data': '{"status":"on"}', 'sid': '158d0001a69623', 'cmd': 'report', 'model': 'plug', 'short_id': 2365}
2018-10-14 15:22:51 DEBUG (MainThread) [homeassistant.components.xiaomi_aqara] PUSH >> <Entity Plug_158d0001a69623: on>: {'status': 'on'}
PaulAnnekov commented 5 years ago

It was broken here https://github.com/home-assistant/home-assistant/commit/b0c1c37cd5d204b3d457d25a22a28fbcf06b6a85#diff-e65409bb5cfa42630d11234d834dd495 by @Anonym-tsk.

He added polling for plug. Now when you're turning plug ON we send write[status=on] and then HA immediately calling update which makes us send read. Aqara gateway returns status=unknown when you're calling read immediately after write. We treat any non-on status as off (https://github.com/home-assistant/home-assistant/blob/dev/homeassistant/components/switch/xiaomi_aqara.py#L143). In several milliseconds gateway sends report[status=on].

That's why you see this flickering (on-off-on).

galoz11 commented 5 years ago

thank you , can it be fix ? i disconnect my gear to the plug becouse it was vibrating the power source and could damage the devise..

PaulAnnekov commented 5 years ago

This change can't make any damage to your load. It still makes single write on power off/on. But it looks weird in UI, yep. I don't have time to fix it now. Maybe @Anonym-tsk will do it.

galoz11 commented 5 years ago

thank you for replay and help. just want to mention that i disable all my authomation and scripts that belong to the switch, becouse with them the power swich vibrate from on to off and vice versa multiple times so the power is vibrate with them include.

can i replace xiaomi_aqara.py ant put the old version (from 0.79.3) insted ? i think this vibration can damage load becouse other scripts working on it (i just enable them and almost damage my fish water pump)

thank you

Anonym-tsk commented 5 years ago

Thanks. I am working to fix this problem.

Anonym-tsk commented 5 years ago

It's strange that you got "status":"unknown". I don't have problems with Zigbee socket.

PaulAnnekov commented 5 years ago

@galoz11 I think you can replace xiaomi_aqara.py from older version w/o any problems. @Anonym-tsk I get "status": "unknown" too, for this plug: https://madrobots.ru/upload/iblock/0a7/0a7bfc1bbdae58f8c3d828a8651c5a96.jpg.

Anonym-tsk commented 5 years ago

@PaulAnnekov I also get it in log. It seems my server is faster and it can process two responses between the async_schedule_update_ha_state and I don't see problem in UI. I'm working to fix it.

galoz11 commented 5 years ago

problem still exist

Anonym-tsk commented 5 years ago

Pull request is still not merged )