Have you added the users (don’t know which users run your OH2):
sudo usermod -a -G dialout openhab
sudo usermod -a -G dialout pi
sudo usermod -a -G dialout root
sudo usermod -G tty openhab
And also if this seems not to be directly related to your problem: You should use the newest OH2 build. Beta 4 or the latest snapshot.
Hi Stefan,
I followed the http://docs.openhab.org/installation/linux.html so openhab is started as user openhab.
The installed version was 2.0.0b3 but the repository seems to have been updated to b4 now.
After adding openhab to the tty and dialout group openhab still reported that it was not able to access the serial port.
Also when checking it as openhab using stty;
sudo -u openhab bash
stty < /dev/ttyAMA0
It returned
bash: /dev/ttyAMA0: Permission denied
Finally fixed it. For some reason the serial port on a clean and updated installation of Raspbian is missing the read permissions on the tty group.
ls -al /dev/ttyAMA0
crw--w---- 1 root tty 204, 64 Sep 16 09:08 /dev/ttyAMA0
So the fix in the end was simple
chmod g+r /dev/ttyAMA0
Finally 
2016-09-16 09:45:54.192 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:1573262d7b3' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
javascript
2016-09-16 09:45:54.195 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyAMA0'
javascript
2016-09-16 09:45:54.304 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
javascript
2016-09-16 09:45:54.330 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - Update networkKey
javascript
2016-09-16 09:45:54.371 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
javascript
2016-09-16 09:45:54.373 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
Next step… including the z-wave devices
Hmmm… after a restart of the openhab2 service the logs show that it able to access the razberry card but seem to fail to communicate
2016-09-16 10:08:47.942 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2016-09-16 10:08:48.686 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
2016-09-16 10:08:49.201 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui
2016-09-16 10:08:49.407 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
2016-09-16 10:08:49.641 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2016-09-16 10:08:54.820 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:1573262d7b3' changed from UNINITIALIZED to INITIALIZING
2016-09-16 10:08:54.839 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:1573262d7b3' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2016-09-16 10:08:54.844 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyAMA0'
2016-09-16 10:08:54.945 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
2016-09-16 10:08:54.970 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - Update networkKey
2016-09-16 10:08:55.008 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2016-09-16 10:08:55.010 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2016-09-16 10:08:58.072 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x5A.
2016-09-16 10:08:58.105 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from NULL to 1
2016-09-16 10:08:58.108 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_sof changed from NULL to 1
2016-09-16 10:08:59.555 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xFF.
2016-09-16 10:08:59.561 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from 1 to 2
2016-09-16 10:09:01.056 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xFF.
2016-09-16 10:09:01.062 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from 2 to 3
2016-09-16 10:09:02.556 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xF8.
2016-09-16 10:09:02.562 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from 3 to 4
2016-09-16 10:09:03.057 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2016-09-16 10:09:08.077 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2016-09-16 10:09:13.097 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2016-09-16 10:09:18.248 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=GetVersion[0x15], type=Request[0x00], priority=High, dest=255, callback=0, payload=
The java property -Dgnu.io.rxtx.SerialPorts=/dev/ttyAMA0 has been added to the EXTRA_JAVA_OPTS_COMMON in /usr/share/openhab2/runtime/karaf/bin/setenv
After enabling zwave debugging and restart of openhab log shows;
2016-09-16 10:19:25.530 [ItemChannelLinkAddedEvent ] - Link 'zwave_serial_zstick_1573262d7b3_serial_can-zwave:serial_zstick:1573262d7b3:serial_can' has been added.
2016-09-16 10:19:25.534 [ItemChannelLinkAddedEvent ] - Link 'zwave_serial_zstick_1573262d7b3_serial_nak-zwave:serial_zstick:1573262d7b3:serial_nak' has been added.
2016-09-16 10:19:25.538 [ItemChannelLinkAddedEvent ] - Link 'zwave_serial_zstick_1573262d7b3_serial_oof-zwave:serial_zstick:1573262d7b3:serial_oof' has been added.
2016-09-16 10:19:25.552 [ItemChannelLinkAddedEvent ] - Link 'zwave_serial_zstick_1573262d7b3_serial_sof-zwave:serial_zstick:1573262d7b3:serial_sof' has been added.
2016-09-16 10:19:25.737 [ItemAddedEvent ] - Item 'zwave_serial_zstick_1573262d7b3_serial_sof' has been added.
2016-09-16 10:19:25.743 [ItemAddedEvent ] - Item 'zwave_serial_zstick_1573262d7b3_serial_ack' has been added.
2016-09-16 10:19:25.747 [ItemAddedEvent ] - Item 'zwave_serial_zstick_1573262d7b3_serial_nak' has been added.
2016-09-16 10:19:25.752 [ItemAddedEvent ] - Item 'zwave_serial_zstick_1573262d7b3_serial_can' has been added.
2016-09-16 10:19:25.757 [ItemAddedEvent ] - Item 'zwave_serial_zstick_1573262d7b3_serial_oof' has been added.
2016-09-16 10:19:25.779 [ThingAddedEvent ] - Thing 'zwave:serial_zstick:1573262d7b3' has been added.
2016-09-16 10:19:29.808 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2016-09-16 10:19:31.497 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
2016-09-16 10:19:32.196 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui
2016-09-16 10:19:32.520 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
2016-09-16 10:19:32.822 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2016-09-16 10:19:32.841 [DEBUG] [org.openhab.binding.zwave ] - BundleEvent STARTING - org.openhab.binding.zwave
2016-09-16 10:19:32.858 [DEBUG] [inding.zwave.internal.ZWaveActivator] - Z-Wave binding started. Version 2.0.0.b4
2016-09-16 10:19:33.172 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.ConfigOptionProvider, org.eclipse.smarthome.config.core.ConfigDescriptionProvider}={component.name=org.openhab.binding.zwave.ConfigDescription, component.id=160, service.id=289, service.bundleid=191, service.scope=bundle} - org.openhab.binding.zwave
2016-09-16 10:19:33.189 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.events.EventFactory}={component.name=org.openhab.binding.zwave.event.BindingEventFactory, component.id=161, service.id=290, service.bundleid=191, service.scope=bundle} - org.openhab.binding.zwave
2016-09-16 10:19:33.341 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=zwave:serial_zstick, thing.id=zwave:serial_zstick:1573262d7b3, service.id=292, service.bundleid=191, service.scope=singleton} - org.openhab.binding.zwave
2016-09-16 10:19:33.355 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.zwave.internal.ZWaveHandlerFactory, component.id=164, service.id=291, service.bundleid=191, service.scope=bundle} - org.openhab.binding.zwave
2016-09-16 10:19:33.365 [DEBUG] [org.openhab.binding.zwave ] - BundleEvent STARTED - org.openhab.binding.zwave
2016-09-16 10:19:37.289 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:1573262d7b3' changed from UNINITIALIZED to INITIALIZING
2016-09-16 10:19:37.293 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2016-09-16 10:19:37.303 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller.
2016-09-16 10:19:37.315 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyAMA0'
2016-09-16 10:19:37.319 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:1573262d7b3' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2016-09-16 10:19:37.419 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Starting receive thread
2016-09-16 10:19:37.428 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
2016-09-16 10:19:37.428 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Starting ZWave thread: Receive
2016-09-16 10:19:37.430 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initialising ZWave controller
2016-09-16 10:19:37.458 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - Update networkKey
2016-09-16 10:19:37.496 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2016-09-16 10:19:37.499 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2016-09-16 10:19:37.509 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Starting ZWave thread: Send
2016-09-16 10:19:37.513 [DEBUG] [ve.internal.protocol.ZWaveController] - Starting ZWave thread: Input
2016-09-16 10:19:37.527 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Activating ZWave discovery service for zwave:serial_zstick:1573262d7b3
2016-09-16 10:19:37.533 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=295, service.bundleid=191, service.scope=singleton} - org.openhab.binding.zwave
2016-09-16 10:19:40.503 [DEBUG] [.ZWaveController$InitializeDelayTask] - Initialising network
2016-09-16 10:19:40.528 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-16 10:19:40.530 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 0. Queue={}
2016-09-16 10:19:40.532 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2016-09-16 10:19:40.534 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2016-09-16 10:19:40.539 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-16 10:19:40.548 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2016-09-16 10:19:40.550 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2016-09-16 10:19:40.552 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (149)
2016-09-16 10:19:40.556 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2016-09-16 10:19:40.562 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_sof changed from NULL to 1
2016-09-16 10:19:40.563 [DEBUG] [rialmessage.GetSucNodeIdMessageClass] - Get SUC NodeID
2016-09-16 10:19:40.565 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2016-09-16 10:19:40.805 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2016-09-16 10:19:42.044 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xF8.
2016-09-16 10:19:42.053 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from NULL to 1
2016-09-16 10:19:43.543 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xFC.
2016-09-16 10:19:43.552 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from 1 to 2
2016-09-16 10:19:45.045 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xFE.
2016-09-16 10:19:45.050 [ItemStateChangedEvent ] - zwave_serial_zstick_1573262d7b3_serial_oof changed from 2 to 3
2016-09-16 10:19:45.578 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2016-09-16 10:19:45.580 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 5. Queue={}
2016-09-16 10:19:45.582 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4
2016-09-16 10:19:45.584 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2016-09-16 10:19:45.587 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2016-09-16 10:19:50.607 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2016-09-16 10:19:50.609 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 5. Queue={}
2016-09-16 10:19:50.611 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4
2016-09-16 10:19:50.613 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2016-09-16 10:19:50.615 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2016-09-16 10:19:55.637 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2016-09-16 10:19:55.643 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 5. Queue={}
2016-09-16 10:19:55.645 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4
2016-09-16 10:19:55.647 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2016-09-16 10:19:55.649 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2016-09-16 10:20:00.667 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=GetVersion[0x15], type=Request[0x00], priority=High, dest=255, callback=0, payload=
2016-09-16 10:20:00.670 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-16 10:20:00.676 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2016-09-16 10:20:00.679 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2016-09-16 10:20:05.697 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2016-09-16 10:20:05.974 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2016-09-16 10:20:05.976 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-16 10:20:05.979 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2016-09-16 10:20:05.982 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2016-09-16 10:20:10.997 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2016-09-16 10:20:10.999 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2016-09-16 10:20:11.001 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-16 10:20:11.004 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2016-09-16 10:20:11.007 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2016-09-16 10:20:16.027 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2016-09-16 10:20:16.050 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2016-09-16 10:20:16.052 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-16 10:20:16.055 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2016-09-16 10:20:16.057 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2016-09-16 10:20:21.077 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=MemoryGetId[0x20], type=Request[0x00], priority=High, dest=255, callback=0, payload=
2016-09-16 10:20:21.098 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2016-09-16 10:20:21.101 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2016-09-16 10:20:21.104 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
2016-09-16 10:20:26.117 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2016-09-16 10:20:26.142 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2016-09-16 10:20:26.144 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2016-09-16 10:20:26.147 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2016-09-16 10:20:26.149 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
It seems that the z-wave software has to be installed. When installing it reports that the AMA0 interface is reconfigured for the razberry.
Preparing AMA0 interface:
removing 'console=ttyAMA0,115200' and 'kgdboc=ttyAMA0,115200 and 'console=serial0,115200' from kernel command line (/boot/cmdline.txt)
removing '*:*:respawn:/sbin/getty ttyAMA0' from /etc/inittab
mv: cannot stat '/tmp/zway_install_inittab': No such file or directory
AMA0 interface reconfigured, please restart Raspberry
Install the software using the instructions
sudo -s
wget -q -O - http://razberry.z-wave.me/install | sudo bash
# Answer questions during install
# disable z-way server
sudo service z-way-server stop
sudo update-rc.d z-way-server disable
## reboot
shutdown -r 0 now
Now when starting openhab the communication with the razberry z-wave card is working properly
2016-09-16 10:32:46.213 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2016-09-16 10:32:46.215 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2016-09-16 10:32:46.223 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Starting ZWave thread: Send
2016-09-16 10:32:46.238 [DEBUG] [ve.internal.protocol.ZWaveController] - Starting ZWave thread: Input
2016-09-16 10:32:46.252 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Activating ZWave discovery service for zwave:serial_zstick:1573262d7b3
2016-09-16 10:32:46.260 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=294, service.bundleid=191, service.scope=singleton} - org.openhab.binding.zwave
2016-09-16 10:32:49.218 [DEBUG] [.ZWaveController$InitializeDelayTask] - Initialising network
2016-09-16 10:32:49.248 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-16 10:32:49.249 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 0. Queue={}
2016-09-16 10:32:49.252 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2016-09-16 10:32:49.254 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-16 10:32:49.256 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2016-09-16 10:32:49.262 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2016-09-16 10:32:49.270 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2016-09-16 10:32:49.278 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 01 15 5A 2D 57 61 76 65 20 33 2E 39 39 00 01 95
And finally successfully included the z-way sensors! To get the open/close door detection working for the ZW089-C the suggested property 121: Configuration Value 4(LSB) SENSOR BINARY had to be changed to enable SENSORY BINARY
Thanks for you support ! 
Here’s a report of a similar problem on Smart Things. I’m still running the zwave 1.8 binding and can’t get my battery levels to report.
Number FrontDoorBattery “Front Door Battery [%d %%]” {zwave=“53:command=BATTERY”}
Any chance this post could help us?
Hi there iam new to Openhab2 and also experiencing the same issues. The ZW089 sensors that i have are not working on Openhab. They can bind i see they get updated when i push the button on them. Buti do not receive any updates from them. I had them previously on Smartthings and there they worked perfectly.
This is the logging i received:
2018-04-05 12:50:40.809 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2018-04-05 12:50:40.818 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2018-04-05 12:50:40.842 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 12:51:19.720 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - NODE 13: setupNetworkKey useSchemeZero=false
2018-04-05 12:51:19.807 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE to ONLINE: Node initialising: DETAILS
2018-04-05 12:51:19.819 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: DETAILS to ONLINE: Node initialising: INCLUSION_START
2018-04-05 12:51:19.831 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: INCLUSION_START to ONLINE: Node initialising: IDENTIFY_NODE
2018-04-05 12:51:19.839 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: IDENTIFY_NODE to ONLINE: Node initialising: MANUFACTURER
2018-04-05 12:51:19.884 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: MANUFACTURER to ONLINE: Node initialising: SECURITY_REPORT
2018-04-05 12:51:19.892 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: SECURITY_REPORT to ONLINE: Node initialising: APP_VERSION
2018-04-05 12:51:19.976 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: APP_VERSION to ONLINE: Node initialising: DISCOVERY_COMPLETE
2018-04-05 12:51:19.983 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: DISCOVERY_COMPLETE to ONLINE: Node initialising: VERSION
2018-04-05 12:51:20.294 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: VERSION to ONLINE: Node initialising: ENDPOINTS
2018-04-05 12:51:20.297 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: ENDPOINTS to ONLINE: Node initialising: UPDATE_DATABASE
2018-04-05 12:51:20.302 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: UPDATE_DATABASE to ONLINE: Node initialising: STATIC_VALUES
2018-04-05 12:51:20.362 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: STATIC_VALUES to ONLINE: Node initialising: ASSOCIATIONS
2018-04-05 12:51:20.713 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - NODE 13: setupNetworkKey useSchemeZero=false
2018-04-05 12:51:33.947 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE: Node initialising: ASSOCIATIONS to OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller
2018-04-05 12:51:43.533 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller to ONLINE
2018-04-05 12:51:43.551 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 12:51:43.562 [WARN ] [l.serialmessage.SendDataMessageClass] - NODE 13: Already processed another send data request for this callback Id, ignoring.
2018-04-05 12:53:18.587 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 12:59:53.655 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:00:21.796 [hingStatusInfoChangedEvent] - ‘zwave:device:f6fa1379:node13’ changed from ONLINE to ONLINE: Node initialising: SET_WAKEUP
2018-04-05 13:00:21.830 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:01:42.904 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:01:42.916 [WARN ] [l.serialmessage.SendDataMessageClass] - NODE 13: Already processed another send data request for this callback Id, ignoring.
2018-04-05 13:01:55.884 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:01:55.893 [WARN ] [l.serialmessage.SendDataMessageClass] - NODE 13: Already processed another send data request for this callback Id, ignoring.
2018-04-05 13:03:37.623 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:04:20.607 [me.event.ThingUpdatedEvent] - Thing ‘zwave:device:f6fa1379:node13’ has been updated.
2018-04-05 13:04:20.629 [WARN ] [l.serialmessage.SendDataMessageClass] - NODE 13: Already processed another send data request for this callback Id, ignoring.
i hope someone can help me with this. All other Zwave devices are working ok.
Also when i try to set the association i get the following error:
[ERROR] [st.core.internal.thing.ThingResource] - Exception during HTTP PUT request for update config at ‘things/zwave:device:f6fa1379:node13/config’