New Errors Since 32.1 Upgrade

jamieb · November 6, 2016, 2:08pm

Updated to 32.1 and now have the below errors, anybody have any ideas?
I’m running in Docker on a Synology. I am running emulated hue and have tried turning off the discovery component. Any help appreciated.

16-11-06 13:26:25 homeassistant.components.light: Error while setting up platform hue
Traceback (most recent call last):
  File "/usr/src/app/homeassistant/helpers/entity_component.py", line 148, in _async_setup_platform
    entity_platform.add_entities, discovery_info
  File "uvloop/future.pyx", line 230, in __iter__ (uvloop/loop.c:94692)
  File "uvloop/task.pyx", line 186, in uvloop.loop.BaseTask._fast_wakeup (uvloop/loop.c:100074)
  File "uvloop/future.pyx", line 101, in uvloop.loop.BaseFuture._result_impl (uvloop/loop.c:93110)
  File "/usr/local/lib/python3.5/concurrent/futures/thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/usr/src/app/homeassistant/components/light/hue.py", line 98, in setup_platform
    setup_bridge(host, hass, add_devices, filename, allow_unreachable)
  File "/usr/src/app/homeassistant/components/light/hue.py", line 108, in setup_bridge
    config_file_path=hass.config.path(filename))
  File "/usr/local/lib/python3.5/site-packages/phue.py", line 435, in __init__
    self.connect()
  File "/usr/local/lib/python3.5/site-packages/phue.py", line 559, in connect
    self.register_app()
  File "/usr/local/lib/python3.5/site-packages/phue.py", line 513, in register_app
    response = self.request('POST', '/api', data)
  File "/usr/local/lib/python3.5/site-packages/phue.py", line 472, in request
    return json.loads(str(result.read(), encoding='utf-8'))
  File "/usr/local/lib/python3.5/json/__init__.py", line 319, in loads
    return _default_decoder.decode(s)
  File "/usr/local/lib/python3.5/json/decoder.py", line 339, in decode
    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
  File "/usr/local/lib/python3.5/json/decoder.py", line 357, in raw_decode
    raise JSONDecodeError("Expecting value", s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)

rogerrally · November 6, 2016, 6:59pm

Sorry, i cannot help, but i am also experiencing errors since upgrading to 32.0 and still have the same problems on 32.1.

16-11-05 18:30:45 homeassistant.components.light: Error while setting up platform hue
Traceback (most recent call last):
File “/srv/hass/lib/python3.5/site-packages/homeassistant/helpers/entity_component.py”, line 148, in _async_setup_platform
entity_platform.add_entities, discovery_info
File “/usr/lib/python3.5/asyncio/futures.py”, line 361, in iter
yield self # This tells Task to wait for completion.
File “/usr/lib/python3.5/asyncio/tasks.py”, line 296, in _wakeup
future.result()
File “/usr/lib/python3.5/asyncio/futures.py”, line 274, in result
raise self._exception
File “/usr/lib/python3.5/concurrent/futures/thread.py”, line 55, in run
result = self.fn(*self.args, **self.kwargs)
File “/srv/hass/lib/python3.5/site-packages/homeassistant/components/light/hue.py”, line 98, in setup_platform
setup_bridge(host, hass, add_devices, filename, allow_unreachable)
File “/srv/hass/lib/python3.5/site-packages/homeassistant/components/light/hue.py”, line 108, in setup_bridge
config_file_path=hass.config.path(filename))
File “/home/hass/.homeassistant/deps/phue.py”, line 435, in init
self.connect()
File “/home/hass/.homeassistant/deps/phue.py”, line 559, in connect
self.register_app()
File “/home/hass/.homeassistant/deps/phue.py”, line 513, in register_app
response = self.request(‘POST’, ‘/api’, data)
File “/home/hass/.homeassistant/deps/phue.py”, line 472, in request
return json.loads(str(result.read(), encoding=‘utf-8’))
File “/usr/lib/python3.5/json/init.py”, line 319, in loads
return _default_decoder.decode(s)
File “/usr/lib/python3.5/json/decoder.py”, line 339, in decode
obj, end = self.raw_decode(s, idx=_w(s, 0).end())
File “/usr/lib/python3.5/json/decoder.py”, line 357, in raw_decode
raise JSONDecodeError(“Expecting value”, s, err.value) from None
json.decoder.JSONDecodeError: Expecting value: line 1 column 1 (char 0)
16-11-05 18:30:45 homeassistant.components.zwave: zwave not ready after 30 seconds, continuing anyway

I am also running emulated hue, and discovery. I have tried switching off both emulated hue and discovery. I do not get my zwave to work either.

My OZW log files is

016-11-05 20:22:41.529 Always, OpenZwave Version 1.4.2146 Starting Up
2016-11-05 20:22:41.600 Info, Setting Up Provided Network Key for Secure Communications
2016-11-05 20:22:41.600 Warning, Failed - Network Key Not Set
2016-11-05 20:22:41.600 Info, mgr, Added driver for controller /dev/zwave
2016-11-05 20:22:41.600 Info, Opening controller /dev/zwave
2016-11-05 20:22:41.600 Info, Trying to open serial port /dev/zwave (attempt 1)
2016-11-05 20:22:41.605 Info, Serial port /dev/zwave opened (attempt 1)
2016-11-05 20:22:41.606 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2016-11-05 20:22:41.606 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2016-11-05 20:22:41.606 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2016-11-05 20:22:41.606 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2016-11-05 20:22:41.606 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2016-11-05 20:22:41.606 Detail,
2016-11-05 20:22:41.606 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2016-11-05 20:22:42.606 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2016-11-05 20:22:42.606 Detail, contrlr, Removing current message
2016-11-05 20:22:42.606 Detail, contrlr, Notification: Notification - TimeOut
2016-11-05 20:22:42.607 Detail,
2016-11-05 20:22:42.607 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2016-11-05 20:22:43.607 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2016-11-05 20:22:43.607 Detail, contrlr, Removing current message
2016-11-05 20:22:43.607 Detail, contrlr, Notification: Notification - TimeOut
2016-11-05 20:22:43.607 Detail,
2016-11-05 20:22:43.607 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2016-11-05 20:22:44.607 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2016-11-05 20:22:44.613 Detail, contrlr, Removing current message
2016-11-05 20:22:44.614 Detail, contrlr, Notification: Notification - TimeOut
2016-11-05 20:22:44.614 Detail,
2016-11-05 20:22:44.614 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2016-11-05 20:22:45.614 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2016-11-05 20:22:45.614 Detail, contrlr, Removing current message
2016-11-05 20:22:45.614 Detail, contrlr, Notification: Notification - TimeOut
2016-11-05 20:22:45.614 Detail,
2016-11-05 20:22:45.614 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2016-11-05 20:22:46.614 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2016-11-05 20:22:46.614 Detail, contrlr, Removing current message
2016-11-05 20:22:46.614 Detail, contrlr, Notification: Notification - TimeOut
2016-11-05 20:51:11.018 Error, mgr, Manager::GetDriver failed - Home ID 0x00000000 is unknown
2016-11-05 20:51:11.018 Warning, Exception: Manager.cpp:373 - 100 - Invalid HomeId passed to GetDriver
2016-11-05 20:51:11.018 Info, mgr, Manager::WriteConfig failed - _homeId 0 not found
2016-11-05 20:51:12.020 Detail, Notification: DriverRemoved
2016-11-05 20:51:12.020 Always, ***************************************************************************
2016-11-05 20:51:12.020 Always, ********************* Cumulative Network Statistics *********************
2016-11-05 20:51:12.020 Always, *** General
2016-11-05 20:51:12.020 Always, Driver run time: . . . 0 days, 0 hours, 28 minutes
2016-11-05 20:51:12.020 Always, Frames processed: . . . . . . . . . . . . . . . . . . . . 0
2016-11-05 20:51:12.020 Always, Total messages successfully received: . . . . . . . . . . 0
2016-11-05 20:51:12.020 Always, Total Messages successfully sent: . . . . . . . . . . . . 5
2016-11-05 20:51:12.020 Always, ACKs received from controller: . . . . . . . . . . . . . 0
2016-11-05 20:51:12.020 Always, *** Errors
2016-11-05 20:51:12.020 Always, Unsolicited messages received while waiting for ACK: . . 0

Any ideas on where to start trying to sort this issue?

Cheers

Roger