Home Assistant & Razberry

You are just trying to point it to the config folder that contains all your z-wave data. Looks like you found it. It seems to vary depending on your install.

I am getting the following in the hass logs . I am running virtual hass on rpi3 with razberry gpio moduel . Appreciate your support :

ERROR:homeassistant.setup:Error during setup of component zwave
Traceback (most recent call last):
File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py”, line 75, in init
raise ZWaveException(u"Can’t write to device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: “Zwave Generic Exception : Can’t write to device /dev/ttyAMA0 : [‘NoneType: None\n’]”

Did you install the z-way-server? If so you’ll need to stop and disable it.

If not, see the documentation.

no the Z-way-server is not installed at all. Should the module be installed on a specific GPOI pins ? I can see it defined as ACM0 then after a while becomes tt7…

It comes with instructions for connecting it - from memory pins zero onwards.

Did you follow the documentation for disabling Bluetooth?

I follow the documentation for disabling bluetooth , no idea though about the connection , but it lits once i installed it , and defined as ttyAMA0 . I get the following log , any idea :

tail -f /home/homeassistant/.homeassistant/home-assistant.log
config_path=config[DOMAIN].get(CONF_CONFIG_PATH))
File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py”, line 81, in init
raise ZWaveException(u"Error when retrieving device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: ‘Zwave Generic Exception : Error when retrieving device /dev/ttyAMA0 : [‘Traceback (most recent call last):\n’, ’ File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py”, line 75, in init\n raise ZWaveException(u"Can\‘t write to device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))\n’, ‘openzwave.object.ZWaveException: “Zwave Generic Exception : Can\'t write to device /dev/ttyAMA0 : [\‘NoneType: None\\\\n\’]”\n’]’
2017-12-20 22:00:42 ERROR (Thread-20) [homeassistant.components.notify.ios] The notify.ios platform was loaded but no devices exist! Please check the documentation at https://home-assistant.io/ecosystem/ios/notifications/ for more information
2017-12-20 22:18:58 ERROR (MainThread) [homeassistant.core] Error doing job: Fatal read error on socket transport
Traceback (most recent call last):
File “/usr/lib/python3.5/asyncio/selector_events.py”, line 723, in _read_ready
data = self._sock.recv(self.max_size)
OSError: [Errno 113] No route to host

Can you run the following commands please:

  • ls -al /dev/ttyAMA0
  • id homeassistant

pi@raspberrypi:~$ ls -al /dev/ttyAMA0
crw–w---- 1 root tty 204, 64 Dec 23 09:55 /dev/ttyAMA0
pi@raspberrypi:~$ id homeassistant
uid=999(homeassistant) gid=996(homeassistant) groups=996(homeassistant),20(dialout)
pi@raspberrypi:~$

See the troubleshooting steps.

when I change the permissions per below , it keeps going back by itself after a while or on restart . I can see the zwave service start on the homeassistant log but this keeps happening , and i guess results in cannot lock controller log when trying to add a zwave sensor . Then i find it back to tty permission :

pi@raspberrypi:~$ ls -l /dev/ttyAMA0
crw–w---- 1 root tty 204, 64 Dec 25 20:14 /dev/ttyAMA0
pi@raspberrypi:~$ sudo chgrp dialout /dev/ttyAMA0
pi@raspberrypi:~$ sudo chmod g+rw /dev/ttyAMA0
pi@raspberrypi:~$ ls -l /dev/ttyAMA0
crw-rw---- 1 root tty 204, 64 Dec 25 20:14 /dev/ttyAMA0
pi@raspberrypi:~$

it worked but i cant seem to be able to add a device , and when the log sasy cannot lock controller , it goes back to :
pi@raspberrypi:~$ ls -l /dev/ttyAMA0
crw–w---- 1 root tty 204, 64 Dec 25 20:14 /dev/ttyAMA0

when I check… logs below too :slight_smile:
2017-12-25 20:14:18 INFO (MainThread) [homeassistant.core] Timer:starting
2017-12-25 20:14:18 INFO (Thread-12) [homeassistant.components.zwave] Starting Z-Wave network…
2017-12-25 20:14:18 INFO (Thread-12) [openzwave] Start Openzwave network.
2017-12-25 20:14:18 INFO (MainThread) [homeassistant.core] Bus:Handling <Event zwave.network_start[L]>
2017-12-25 20:14:30 INFO (MainThread) [homeassistant.components.http] Serving /api/websocket to 192.168.2.5 (auth: True)
2017-12-25 20:14:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.2, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=287.75 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.15, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=287.66 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:14:30 INFO (MainThread) [homeassistant.components.http] Serving /api/config/customize/config/zone.home to 192.168.2.5 (auth: True)
2017-12-25 20:14:30 INFO (MainThread) [homeassistant.components.http] Serving /api/cloud/account to 192.168.2.5 (auth: True)
2017-12-25 20:14:32 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 36743, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘vnAKCg==’, ‘ci’: ‘10’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:0a:54:39:d3:12:e5:26’, ‘md’: ‘Temp’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:14:32 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 35329, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘PMg4rw==’, ‘ci’: ‘10’, ‘s#’: ‘1’, ‘c#’: ‘6’, ‘id’: ‘00:a1:f5:c7:a2:22:2b:c8’, ‘md’: ‘Humidity’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:14:32 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 34699, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘p+GHHw==’, ‘ci’: ‘9’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:f5:ba:46:36:9a:39:a8’, ‘md’: ‘Thermostat’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:14:32 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 46669, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘XRApjQ==’, ‘ci’: ‘5’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:00:84:74:5e:85:dd:04’, ‘md’: ‘LED’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:14:32 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: home_assistant {‘host’: ‘192.168.2.27’, ‘port’: 8123, ‘properties’: {‘base_url’: ‘http://192.168.2.27:8123’, ‘requires_api_password’: False, ‘version’: ‘0.60.0’}, ‘hostname’: ‘Home._home-assistant._tcp.local.’}
2017-12-25 20:14:48 WARNING (Thread-12) [homeassistant.components.zwave] zwave not ready after 30 seconds, continuing anyway
2017-12-25 20:14:48 INFO (Thread-12) [homeassistant.components.zwave] final network state: 0 Network is stopped
2017-12-25 20:14:48 INFO (Thread-12) [homeassistant.components.zwave] Z-Wave polling interval set to 60000 ms
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=add_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=add_node_secure>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=remove_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=cancel_command>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=heal_network>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=soft_reset>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=test_network>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=stop_network>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=start_network>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=rename_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=rename_value>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=set_config_parameter>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=print_config_parameter>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=remove_failed_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=replace_failed_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=change_association>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=set_wakeup>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=print_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=refresh_entity>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=refresh_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=reset_node_meters>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=set_poll_intensity>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=heal_node>
2017-12-25 20:14:48 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=zwave, service=test_node>
2017-12-25 20:15:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.41, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.06 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.2, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=287.75 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:15:32 INFO (MainThread) [homeassistant.components.http] Serving /api/zwave/ozwlog to 192.168.2.5 (auth: True)
2017-12-25 20:15:51 INFO (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: service_call_id=1974007824-3, domain=zwave, service=add_node, service_data=>
2017-12-25 20:15:51 INFO (Thread-3) [homeassistant.components.zwave] Z-Wave add_node have been initialized
2017-12-25 20:16:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.61, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.38 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.41, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.06 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:17:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.82, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.7 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.61, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.38 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>

2017-12-25 20:18:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-71.02, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=289.03 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-70.82, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=288.7 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:19:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-71.22, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=289.36 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-71.02, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=289.03 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:19:32 ERROR (Thread-5) [homeassistant.core] Error doing job: Future exception was never retrieved
Traceback (most recent call last):
File “/usr/lib/python3.5/concurrent/futures/thread.py”, line 55, in run
result = self.fn(*self.args, **self.kwargs)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/core.py”, line 1036, in execute_service
service_handler.func(service_call)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zwave/init.py”, line 375, in add_node
network.controller.add_node()
File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/controller.py”, line 657, in add_node
return self._network.manager.addNode(self.home_id, doSecurity)
File “src-lib/libopenzwave/libopenzwave.pyx”, line 4270, in libopenzwave.PyManager.addNode (openzwave-embed/open-zwave-master/python-openzwave/src-lib/libopenzwave/libopenzwave.cpp:31649)
TypeError: an integer is required
2017-12-25 20:19:44 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 36743, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘vnAKCg==’, ‘ci’: ‘10’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:0a:54:39:d3:12:e5:26’, ‘md’: ‘Temp’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:19:44 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 35329, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘PMg4rw==’, ‘ci’: ‘10’, ‘s#’: ‘1’, ‘c#’: ‘6’, ‘id’: ‘00:a1:f5:c7:a2:22:2b:c8’, ‘md’: ‘Humidity’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:19:44 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 34699, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘p+GHHw==’, ‘ci’: ‘9’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:f5:ba:46:36:9a:39:a8’, ‘md’: ‘Thermostat’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:19:44 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: homekit {‘host’: ‘192.168.2.27’, ‘port’: 46669, ‘properties’: {‘pv’: ‘1.0’, ‘ff’: ‘0’, ‘sh’: ‘XRApjQ==’, ‘ci’: ‘5’, ‘s#’: ‘1’, ‘c#’: ‘2’, ‘id’: ‘00:00:84:74:5e:85:dd:04’, ‘md’: ‘LED’, ‘sf’: ‘0’}, ‘hostname’: ‘raspberrypi.local.’}
2017-12-25 20:19:44 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: home_assistant {‘host’: ‘192.168.2.27’, ‘port’: 8123, ‘properties’: {‘base_url’: ‘http://192.168.2.27:8123’, ‘requires_api_password’: False, ‘version’: ‘0.60.0’}, ‘hostname’: ‘Home._home-assistant._tcp.local.’}
2017-12-25 20:20:09 INFO (MainThread) [homeassistant.components.http] Serving /api/config/customize/config/zone.home to 192.168.2.5 (auth: True)
2017-12-25 20:20:09 INFO (MainThread) [homeassistant.components.http] Serving /api/cloud/account to 192.168.2.5 (auth: True)
2017-12-25 20:20:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-71.42, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=289.7 @ 2017-12-25T22:14:13.963750+02:00>, old_state=<state sun.sun=below_horizon; next_rising=2017-12-26T04:32:12+00:00, next_dawn=2017-12-26T04:05:32+00:00, next_noon=2017-12-26T09:36:24+00:00, friendly_name=Sun, elevation=-71.22, next_dusk=2017-12-26T15:07:17+00:00, next_setting=2017-12-26T14:40:37+00:00, next_midnight=2017-12-25T21:36:37+00:00, azimuth=289.36 @ 2017-12-25T22:14:13.963750+02:00>, entity_id=sun.sun>
2017-12-25 20:20:44 INFO (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: service_call_id=1974007824-4, domain=zwave, service=add_node, service_data=>
2017-12-25 20:20:44 INFO (Thread-18) [homeassistant.components.zwave] Z-Wave add_node have been initialized
2017-12-25 20:20:44 WARNING (Thread-18) [openzwave] Can’t lock controller for command : add_node
2017-12-25 20:20:44 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_executed[L]: service_call_id=1974007824-4>

OZW LOG :

2017-12-25 20:14:16.700 Always, OpenZwave Version 1.4.2586 Starting Up
2017-12-25 20:14:18.250 Info, Setting Up Provided Network Key for Secure Communications
2017-12-25 20:14:18.250 Info, mgr, Added driver for controller /dev/ttyAMA0
2017-12-25 20:14:18.250 Info, Opening controller /dev/ttyAMA0
2017-12-25 20:14:18.250 Info, Trying to open serial port /dev/ttyAMA0 (attempt 1)
2017-12-25 20:14:18.251 Info, Serial port /dev/ttyAMA0 opened (attempt 1)
2017-12-25 20:14:18.251 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2017-12-25 20:14:18.251 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2017-12-25 20:14:18.251 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2017-12-25 20:14:18.251 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2017-12-25 20:14:18.251 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2017-12-25 20:14:18.251 Detail,
2017-12-25 20:14:18.251 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2017-12-25 20:14:18.254 Detail, contrlr, Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x30, 0x35, 0x00, 0x01, 0x97
2017-12-25 20:14:18.254 Detail,
2017-12-25 20:14:18.254 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2017-12-25 20:14:18.254 Info, contrlr, Static Controller library, version Z-Wave 4.05
2017-12-25 20:14:18.254 Detail, Node045, Expected reply was received
2017-12-25 20:14:18.254 Detail, Node045, Message transaction complete
2017-12-25 20:14:18.254 Detail,
2017-12-25 20:14:18.254 Detail, contrlr, Removing current message
2017-12-25 20:14:18.254 Detail,
2017-12-25 20:14:18.255 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2017-12-25 20:14:28.255 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2017-12-25 20:14:28.255 Detail, contrlr, Removing current message
2017-12-25 20:14:28.255 Detail, contrlr, Notification: Notification - TimeOut
2017-12-25 20:14:28.255 Detail,
2017-12-25 20:14:28.256 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2017-12-25 20:14:29.256 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2017-12-25 20:14:29.256 Detail, contrlr, Removing current message
2017-12-25 20:14:29.256 Detail, contrlr, Notification: Notification - TimeOut
2017-12-25 20:14:29.256 Detail,
2017-12-25 20:14:29.256 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2017-12-25 20:14:30.257 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2017-12-25 20:14:30.257 Detail, contrlr, Removing current message
2017-12-25 20:14:30.257 Detail, contrlr, Notification: Notification - TimeOut
2017-12-25 20:14:30.257 Detail,
2017-12-25 20:14:30.257 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2017-12-25 20:14:31.257 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2017-12-25 20:14:31.258 Detail, contrlr, Removing current message
2017-12-25 20:14:31.258 Detail, contrlr, Notification: Notification - TimeOut

Something must be resetting the permissions. Try creating /etc/udev/rules.d/99-ama.rules with the following content:

KERNEL=="ttyAMA0", GROUP="dialout", MODE="0660", SYMLINK+="zwave"

You’ll then need to reboot, and that should then fix the permissions

same thing . I created the file with the contents , set the permissions again , rebooted , then it reverted back to the same permissions.

so does this mean things in the OZW looks fine and what am facing is a permission issues . becuase when the permission is even fine , I couldnt pair a zwave sensor till now … am a bit confused if the setup looks fine till now or no…

getting this after sometime of trying to pair a zwave device :

2017-12-25 21:13:51 ERROR (zeroconf-Engine) [homeassistant.core] Error doing job: Future exception was never retrieved
Traceback (most recent call last):
File “/usr/lib/python3.5/concurrent/futures/thread.py”, line 55, in run
result = self.fn(*self.args, **self.kwargs)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/core.py”, line 1036, in execute_service
service_handler.func(service_call)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zwave/init.py”, line 375, in add_node
network.controller.add_node()
File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/controller.py”, line 657, in add_node
return self._network.manager.addNode(self.home_id, doSecurity)
File “src-lib/libopenzwave/libopenzwave.pyx”, line 4270, in libopenzwave.PyManager.addNode (openzwave-embed/open-zwave-master/python-openzwave/src-lib/libopenzwave/libopenzwave.cpp:31649)
TypeError: an integer is required
2017-12-25 21:13:51 ERROR (zeroconf-Engine) [homeassistant.core] Error doing job: Future exception was never retrieved
Traceback (most recent call last):
File “/usr/lib/python3.5/concurrent/futures/thread.py”, line 55, in run
result = self.fn(*self.args, **self.kwargs)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/core.py”, line 1036, in execute_service
service_handler.func(service_call)
File “/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zwave/init.py”, line 400, in soft_reset
network.controller.soft_reset()
File “/srv/homeassistant/lib/python3.5/site-packages/openzwave/controller.py”, line 579, in soft_reset
self._network.manager.softResetController(self.home_id)
File “src-lib/libopenzwave/libopenzwave.pyx”, line 4106, in libopenzwave.PyManager.softResetController (openzwave-embed/open-zwave-master/python-openzwave/src-lib/libopenzwave/libopenzwave.cpp:31089)
TypeError: an integer is required

You need to find what’s causing that, and fix it.

You might be easier off starting with a fresh build of Hassbian

the permission issued worked with me with with reboot to with executing :

sudo systemctl mask [email protected]

now i need to check the zwave stuff.

looks like am good , I can see the zwave as ready on the main page :slight_smile: I will update if I was able to set up my first zwave sensor

hey abed, any update? :roll_eyes:

Is there any need to ever update the RazBerry firmware? How would this be done? (I have the board successfully installed and working on a PI 3 using hassbian.)