[SOLVED] Openhab2 Configuration of Aeon Zstick Gen5 USB Controller (ZW090)

Thanks for your help Dim,

I tried the Security enabled jar linked from the post above and also tried using the latest snapshot from the zwave git repo (2.1.0). I have removed every node from my controller and used a completely vanilla openhab 2.0 and 2.1.0 base install. For some reason I can’t get my lock (a kwikset 914trl) to securely pair. There are others on this forum who have been successful (Kwikset 914 Inclusion) but nothing I try seems to allow for secure inclusion. The Lock’s attribute tab in habmin has a question mark next to security.

My debug log on re-including the device is below:

2017-05-31 23:19:01.194 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:15c47b89ff1:node9' to inbox.
2017-05-31 23:19:01.194 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave controller start inclusion - mode 2
2017-05-31 23:19:01.195 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Setting controller into INCLUSION mode, highPower:true networkWide:true.
2017-05-31 23:19:01.196 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-05-31 23:19:01.196 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A C1 01 70 
2017-05-31 23:19:01.196 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A C1 01 70 
2017-05-31 23:19:01.196 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 0. Queue={}
2017-05-31 23:19:01.198 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 01 01 00 00 B2 
2017-05-31 23:19:01.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-05-31 23:19:01.198 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 07 00 4A 01 01 00 00 B2 
2017-05-31 23:19:01.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 07 00 4A 01 01 00 00 B2 
2017-05-31 23:19:01.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 01 00 00 
2017-05-31 23:19:01.198 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Learn ready.
2017-05-31 23:19:01.199 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInclusionEvent
2017-05-31 23:19:01.200 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=C1 01 
2017-05-31 23:19:01.200 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 01 00 00 
2017-05-31 23:19:01.200 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=AddNodeToNetwork, callback id=0, expected=AddNodeToNetwork, cancelled=false        transaction complete!
2017-05-31 23:19:01.200 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-05-31 23:19:01.200 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 4ms/2456ms.
2017-05-31 23:19:07.100 [DEBUG] [org.openhab.binding.zwave           ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=350, service.bundleid=38, service.scope=singleton} - org.openhab.binding.zwave
2017-05-31 23:19:07.101 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-05-31 23:19:07.104 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Handler disposed. Unregistering listener.
2017-05-31 23:19:07.106 [DEBUG] [org.openhab.binding.zwave           ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=350, service.bundleid=38, service.scope=singleton} - org.openhab.binding.zwave
2017-05-31 23:19:07.109 [WARN ] [home.core.thing.binding.ThingFactory] - Could not create channel 'alarm_number' for thing type 'zwave:device:15c47b89ff1:node9', because channel type 'zwave:alarm_number' could not be found.
2017-05-31 23:19:07.114 [DEBUG] [org.openhab.binding.zwave           ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=351, service.bundleid=38, service.scope=singleton} - org.openhab.binding.zwave
2017-05-31 23:19:07.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.
2017-05-31 23:19:07.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Controller status changed to ONLINE.
2017-05-31 23:19:07.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Controller is ONLINE. Starting device initialisation.
2017-05-31 23:19:07.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating node properties.
2017-05-31 23:19:07.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating node properties. MAN=144
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating node properties. MAN=144. SET. Was 144
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Property to update: config_31_1_10000000, 1, 1
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Property to update: config_40_1_wo, 0, 0
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Property to update: config_31_1_01000000, 0, 0
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Property to update: config_31_1_00100000, 1, 1
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising Thing Node...
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising channel zwave:device:15c47b89ff1:node9:lock_door
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising cmd channel zwave:device:15c47b89ff1:node9:lock_door
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising poll channel zwave:device:15c47b89ff1:node9:lock_door
2017-05-31 23:19:07.124 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising state channel zwave:device:15c47b89ff1:node9:lock_door
2017-05-31 23:19:07.125 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising channel zwave:device:15c47b89ff1:node9:battery-level
2017-05-31 23:19:07.126 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising cmd channel zwave:device:15c47b89ff1:node9:battery-level
2017-05-31 23:19:07.126 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising poll channel zwave:device:15c47b89ff1:node9:battery-level
2017-05-31 23:19:07.126 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Initialising state channel zwave:device:15c47b89ff1:node9:battery-level
2017-05-31 23:19:07.128 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling intialised at 1800 seconds - start in 1800000 milliseconds.

I must be missing something. Any ideas?