In trying to resolve this, I did a complete purge and reinstall of OH2, and then added the user openhab to the dialout group as well.
I was able to set the binding to use /dev/ttyACM0 when first installing the binding. But now after a reboot, the Controller still shows as offline. I also do not have a lock file any longer in /var/lock so really have no idea why its not connecting.
This is the log info from OH2, and possibly still something with the serial binding? You can see the WARN info there.
2017-01-02 09:16:46.822 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
2017-01-02 09:16:48.303 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2017-01-02 09:16:48.809 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
2017-01-02 09:16:48.974 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui
2017-01-02 09:16:49.125 [DEBUG] [org.openhab.binding.zwave ] - BundleEvent STARTING - org.openhab.binding.zwave
2017-01-02 09:16:49.198 [DEBUG] [inding.zwave.internal.ZWaveActivator] - Z-Wave binding started. Version 2.0.0.201701021217
2017-01-02 09:16:49.200 [DEBUG] [org.openhab.binding.zwave ] - BundleEvent STARTED - org.openhab.binding.zwave
2017-01-02 09:16:49.216 [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=189, service.id=313, service.bundleid=202, service.scope=bundle} - org.openhab.binding.zwave
2017-01-02 09:16:49.345 [INFO ] [ding.astro.internal.bus.AstroBinding] - AstroConfig[latitude=42.898236,longitude=-78.6342,interval=43200,systemTimezone=America/New_York (EST -0500),daylightSavings=false]
2017-01-02 09:16:49.552 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.zwave.internal.ZWaveHandlerFactory, component.id=190, service.id=314, service.bundleid=202, service.scope=bundle} - org.openhab.binding.zwave
2017-01-02 09:16:49.663 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.events.EventFactory}={component.name=org.openhab.binding.zwave.event.BindingEventFactory, component.id=192, service.id=315, service.bundleid=202, service.scope=bundle} - org.openhab.binding.zwave
2017-01-02 09:16:50.039 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2017-01-02 09:16:50.161 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2017-01-02 09:16:52.408 [INFO ] [ding.astro.internal.job.JobScheduler] - Scheduled a daily job at midnight for astro calculation
2017-01-02 09:16:52.986 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2017-01-02 09:16:52.986 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller.
2017-01-02 09:16:52.997 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyACM0'
2017-01-02 09:16:53.008 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=330, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.010 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=331, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.012 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=332, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.013 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=333, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.043 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=334, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.045 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=335, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.050 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=336, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.069 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=337, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.089 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=338, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.091 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=339, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.106 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=340, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.108 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=341, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.110 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=342, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.113 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=343, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.132 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=344, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.133 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.136 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=345, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.136 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.137 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: MANUFACTURER not set
2017-01-02 09:16:53.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.139 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.139 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.147 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.147 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.148 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.148 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.149 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.149 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.152 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.155 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Starting receive thread
2017-01-02 09:16:53.156 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-01-02 09:16:53.171 [INFO ] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
2017-01-02 09:16:53.171 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initialising ZWave controller
2017-01-02 09:16:53.174 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - Update networkKey
2017-01-02 09:16:53.179 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Starting ZWave thread: Receive
2017-01-02 09:16:53.195 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2017-01-02 09:16:53.195 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2017-01-02 09:16:53.201 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Starting ZWave thread: Send
2017-01-02 09:16:53.204 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Activating ZWave discovery service for zwave:serial_zstick:1587fb1d72a
2017-01-02 09:16:53.205 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=346, service.bundleid=202, service.scope=singleton} - org.openhab.binding.zwave
2017-01-02 09:16:53.206 [DEBUG] [ve.internal.protocol.ZWaveController] - Starting ZWave thread: Input
2017-01-02 09:16:53.678 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xFF.
2017-01-02 09:16:54.133 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x09.
2017-01-02 09:16:54.134 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:16:54.149 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x27.
2017-01-02 09:16:54.234 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xD2.
2017-01-02 09:16:54.757 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 01 01 01
2017-01-02 09:16:54.757 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Message is invalid, discarding
2017-01-02 09:16:54.807 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:16:55.094 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:16:56.197 [DEBUG] [.ZWaveController$InitializeDelayTask] - Initialising network
2017-01-02 09:16:56.202 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-02 09:16:56.202 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2017-01-02 09:16:56.202 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2017-01-02 09:16:56.205 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 0. Queue={}
2017-01-02 09:16:56.207 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-01-02 09:16:56.208 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2017-01-02 09:16:56.210 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2017-01-02 09:16:56.211 [DEBUG] [rialmessage.GetSucNodeIdMessageClass] - Get SUC NodeID
2017-01-02 09:16:56.211 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2017-01-02 09:16:56.658 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:16:57.502 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x04.
2017-01-02 09:16:58.123 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:01.207 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2017-01-02 09:17:01.208 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 5. Queue={}
2017-01-02 09:17:01.208 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4
2017-01-02 09:17:01.208 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9
2017-01-02 09:17:01.208 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9
2017-01-02 09:17:01.792 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:02.533 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x33.
2017-01-02 09:17:02.538 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x39.
2017-01-02 09:17:02.544 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:17:02.545 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (153)
2017-01-02 09:17:02.545 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:02.545 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 01 15 5A 2D 57 61 76 65 20 33 2E 39 35 00 01 99
2017-01-02 09:17:02.573 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-02 09:17:02.573 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 01 15 5A 2D 57 61 76 65 20 33 2E 39 35 00 01 99
2017-01-02 09:17:02.573 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 01 15 5A 2D 57 61 76 65 20 33 2E 39 35 00 01 99
2017-01-02 09:17:02.574 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=GetVersion[0x15], type=Response[0x01], priority=High, dest=255, callback=0, payload=5A 2D 57 61 76 65 20 33 2E 39 35 00 01
2017-01-02 09:17:02.580 [DEBUG] [serialmessage.GetVersionMessageClass] - Got MessageGetVersion response. Version = Z-Wave 3.95, Library Type = 0x01
2017-01-02 09:17:02.585 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=GetVersion[0x15], type=Request[0x00], priority=High, dest=255, callback=0, payload=
2017-01-02 09:17:02.586 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=GetVersion[0x15], type=Response[0x01], priority=High, dest=255, callback=0, payload=5A 2D 57 61 76 65 20 33 2E 39 35 00 01
2017-01-02 09:17:02.593 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=GetVersion, callback id=0, expected=GetVersion, cancelled=false transaction complete!
2017-01-02 09:17:02.593 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-01-02 09:17:02.594 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 1077ms/1077ms.
2017-01-02 09:17:02.594 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2017-01-02 09:17:02.594 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2017-01-02 09:17:02.594 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2017-01-02 09:17:07.596 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2017-01-02 09:17:07.597 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2017-01-02 09:17:07.597 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2017-01-02 09:17:07.597 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2017-01-02 09:17:07.597 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2017-01-02 09:17:08.259 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:08.263 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (232)
2017-01-02 09:17:08.263 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:08.291 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (0)
2017-01-02 09:17:08.542 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:12.991 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2017-01-02 09:17:12.991 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2017-01-02 09:17:12.991 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2017-01-02 09:17:12.991 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2017-01-02 09:17:12.991 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2017-01-02 09:17:18.146 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2017-01-02 09:17:18.147 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2017-01-02 09:17:18.147 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2017-01-02 09:17:18.148 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC
2017-01-02 09:17:18.148 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC
2017-01-02 09:17:18.774 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:20.540 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x07.
2017-01-02 09:17:20.541 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:17:20.566 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x03.
2017-01-02 09:17:23.513 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x07.
2017-01-02 09:17:23.513 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:17:23.521 [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=
2017-01-02 09:17:23.521 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2017-01-02 09:17:23.521 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2017-01-02 09:17:23.521 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
2017-01-02 09:17:24.163 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x04.
2017-01-02 09:17:25.041 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:26.399 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:27.774 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:28.525 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2017-01-02 09:17:28.525 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2017-01-02 09:17:28.525 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2017-01-02 09:17:28.525 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2017-01-02 09:17:28.526 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
2017-01-02 09:17:33.527 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2017-01-02 09:17:33.527 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2017-01-02 09:17:33.527 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2017-01-02 09:17:33.527 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2017-01-02 09:17:33.527 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
2017-01-02 09:17:34.022 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (1)
2017-01-02 09:17:34.272 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:39.021 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2017-01-02 09:17:39.021 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2017-01-02 09:17:39.021 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2017-01-02 09:17:39.021 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB
2017-01-02 09:17:39.021 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB
2017-01-02 09:17:40.299 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Frame length is out of limits (124)
2017-01-02 09:17:40.301 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 27 20 9A 41 B1
2017-01-02 09:17:40.302 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Message is invalid, discarding
2017-01-02 09:17:40.802 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:41.981 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:44.025 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=SerialApiGetCapabilities[0x07], type=Request[0x00], priority=High, dest=255, callback=0, payload=
2017-01-02 09:17:44.025 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2017-01-02 09:17:44.025 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 06 96 0F 65
2017-01-02 09:17:44.026 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 06 96 0F 65
2017-01-02 09:17:44.287 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 04 13 01 01
2017-01-02 09:17:44.287 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Message is invalid, discarding
2017-01-02 09:17:44.290 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x04.
2017-01-02 09:17:44.298 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xE8.
2017-01-02 09:17:44.302 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x04.
2017-01-02 09:17:44.553 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Timeout - Sending NAK
2017-01-02 09:17:44.972 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:17:45.506 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xAB.
2017-01-02 09:17:45.983 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x22.
2017-01-02 09:17:45.986 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x00.
2017-01-02 09:17:45.987 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x02.
2017-01-02 09:17:45.994 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x98.
2017-01-02 09:17:45.994 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x81.
2017-01-02 09:17:46.008 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x64.
2017-01-02 09:17:46.011 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xAB.
2017-01-02 09:17:46.012 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x68.
2017-01-02 09:17:46.017 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xF1.
2017-01-02 09:17:46.017 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x2A.
2017-01-02 09:17:46.017 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x40.
2017-01-02 09:17:46.018 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xD3.
2017-01-02 09:17:46.018 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xC4.
2017-01-02 09:17:46.018 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x78.
2017-01-02 09:17:46.018 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xA9.
2017-01-02 09:17:46.019 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xB6.
2017-01-02 09:17:46.019 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x44.
2017-01-02 09:17:46.019 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0xCF.
2017-01-02 09:17:46.020 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x65.
2017-01-02 09:17:49.029 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2017-01-02 09:17:49.029 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2017-01-02 09:17:49.029 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2017-01-02 09:17:49.029 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 06 96 0F 65
2017-01-02 09:17:49.030 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 06 96 0F 65
2017-01-02 09:17:54.376 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2017-01-02 09:17:54.376 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2017-01-02 09:17:54.377 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2017-01-02 09:17:54.377 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 06 96 0F 65
2017-01-02 09:17:54.377 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 06 96 0F 65
2017-01-02 09:17:59.748 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2017-01-02 09:17:59.748 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2017-01-02 09:17:59.748 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2017-01-02 09:17:59.748 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 06 96 0F 65
2017-01-02 09:17:59.748 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 06 96 0F 65
2017-01-02 09:18:04.757 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=SerialApiSetTimeouts[0x06], type=Request[0x00], priority=High, dest=255, callback=0, payload=96 0F
2017-01-02 09:18:04.757 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-02 09:18:04.757 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 56 AA
2017-01-02 09:18:04.757 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 56 AA
2017-01-02 09:18:10.131 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left!
2017-01-02 09:18:10.132 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-01-02 09:18:10.132 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-02 09:18:10.132 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 56 AA
2017-01-02 09:18:10.132 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 56 AA
2017-01-02 09:18:15.500 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 1 attempts left!
2017-01-02 09:18:15.500 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-01-02 09:18:15.501 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-02 09:18:15.505 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 56 AA
2017-01-02 09:18:15.505 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 56 AA
2017-01-02 09:18:15.878 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 00 01 01
2017-01-02 09:18:15.878 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Message is invalid, discarding
2017-01-02 09:18:15.887 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (OOF). Got 0x56.
2017-01-02 09:18:18.574 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - ZWave product zwave:device has no references!
2017-01-02 09:18:18.575 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - ZWave product zwave:serial_zstick has no references!
2017-01-02 09:18:20.871 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Timeout while sending message. Requeueing - 0 attempts left!
2017-01-02 09:18:20.871 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-01-02 09:18:20.871 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-02 09:18:20.871 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 56 AA
2017-01-02 09:18:20.872 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 56 AA
2017-01-02 09:18:26.255 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=GetSucNodeId[0x56], type=Request[0x00], priority=High, dest=255, callback=0, payload=