Testing Z-Wave binding on openHAB-2

I found an error in the definition of these parameters - the “Allow free entry” box wasn’t ticked.

Allow free entry: If the parameter has some options defined, these will be presented in a list in the UI. By enabling ‘allow free entry’, you allow the user to type in any other value as well as these options. Sometimes the manufacturer might set an allowable range, but specific values might have special meaning. For example, a parameter might be used to set the position volume of an alarm between 0 and 100%, but a value of 255 might be used to set a special function. In this case, ‘Allow free entry’ can be set, and an option can be added for the special function. The user can still type in any value they like, but they get the option of the special value as well.

In theory, this option should allow you to provide options (eg ON and OFF), but still allow the user to type a value between 1 and 100. I’m not sure if I’ve tested this in HABmin, so I’m not 100% sure it works, but that’s the concept at least, and if it’s not working, then we should solve that problem rather than removing the options from the database.

makes sense
but as an editor … I dont see that box and hence cannot tick / untick it :slight_smile:

Really - I think you should. If I log in as an editor, I can see it just fine…

I see its in edit of parameter and not the options…
didnt know that actually has influence on options
ok so all good and I know for future editing

after my recent restart of openhab one of my nodes is constantly looping the following:

1:22:58.886 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:58.888 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:58.889 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 5: stageAdvanced(false)
11:22:58.890 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:58.891 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:58.892 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3212. Queue={}
11:22:58.893 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 332ms/1862ms.
11:22:58.893 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3211
11:22:58.894 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 09 92 
11:22:58.895 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 09 92 
11:22:58.904 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B 
11:22:58.906 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:58.907 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B 
11:22:58.908 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B 
11:22:58.909 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:58.910 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.
11:22:58.911 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:58.912 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:58.913 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, callback id=0, expected=ApplicationUpdate, cancelled=false      MISMATCH
11:22:59.135 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.138 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.139 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.140 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.142 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.142 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 9: Application update request. Node information received.
11:22:59.143 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class ASSOCIATION_GROUP_INFO
11:22:59.144 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class FIRMWARE_UPDATE_MD
11:22:59.145 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is awake with 0 messages in the wake-up queue.
11:22:59.146 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
11:22:59.146 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveWakeUpEvent
11:22:59.147 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.147 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: queue length(1), free to send(false)
11:22:59.148 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Initialisation retry timer started 10000
11:22:59.148 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.149 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3212. Queue={}
11:22:59.150 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.150 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(1), free to send(false)
11:22:59.151 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.151 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3213. Queue={}
11:22:59.152 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.152 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(1), free to send(false)
11:22:59.152 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.153 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3214. Queue={}
11:22:59.154 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.155 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.156 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=0, expected=ApplicationUpdate, cancelled=false        transaction complete!
11:22:59.156 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
11:22:59.157 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.157 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.158 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.158 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.159 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.159 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.160 [ERROR] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: Retries exceeded at DETAILS
11:22:59.160 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Retry timout: Can't advance
11:22:59.161 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.161 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.162 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.162 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.163 [ERROR] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: Retries exceeded at DETAILS
11:22:59.181 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Retry timout: Can't advance
11:22:59.182 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 286ms/1862ms.
11:22:59.183 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3213
11:22:59.184 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 09 92 
11:22:59.185 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 09 92 
11:22:59.194 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B 
11:22:59.196 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.197 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B 
11:22:59.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B 
11:22:59.199 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:59.200 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.
11:22:59.201 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.202 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:59.203 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, callback id=0, expected=ApplicationUpdate, cancelled=false      MISMATCH
11:22:59.458 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.464 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.467 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.469 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.471 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.472 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 9: Application update request. Node information received.
11:22:59.474 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class ASSOCIATION_GROUP_INFO
11:22:59.476 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class FIRMWARE_UPDATE_MD
11:22:59.477 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is awake with 0 messages in the wake-up queue.
11:22:59.478 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
11:22:59.480 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveWakeUpEvent
11:22:59.481 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.482 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: queue length(1), free to send(false)
11:22:59.483 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Initialisation retry timer started 10000
11:22:59.483 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.484 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3214. Queue={}
11:22:59.485 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.485 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.487 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 1: stageAdvanced(false)
11:22:59.489 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.490 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.491 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3215. Queue={}
11:22:59.492 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.493 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.494 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 1: stageAdvanced(false)
11:22:59.496 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.497 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.498 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3216. Queue={}
11:22:59.499 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.502 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.503 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=0, expected=ApplicationUpdate, cancelled=false        transaction complete!
11:22:59.504 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
11:22:59.506 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.507 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.508 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.508 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.509 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.510 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.510 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 2: stageAdvanced(false)
11:22:59.511 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.512 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.514 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3217. Queue={}
11:22:59.515 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.516 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.516 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.517 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.518 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 2: stageAdvanced(false)
11:22:59.519 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.519 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.520 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3218. Queue={}
11:22:59.521 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 335ms/1862ms.
11:22:59.523 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3217
11:22:59.524 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 09 92 
11:22:59.526 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 09 92 
11:22:59.559 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 06 00 49 81 00 00 31 
11:22:59.561 [ERROR] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (CAN), resending
11:22:59.562 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.564 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 06 00 49 81 00 00 31 
11:22:59.565 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 06 00 49 81 00 00 31 
11:22:59.566 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=81 00 00 
11:22:59.567 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 255: Application update request. Node Info Request Failed.
11:22:59.568 [ERROR] [essage.ApplicationUpdateMessageClass] - NODE 255: Got Node Info Request Failed. Requeueing
11:22:59.569 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3218. Queue={}
11:22:59.570 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.571 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=81 00 00 
11:22:59.571 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=0, expected=ApplicationUpdate, cancelled=true      MISMATCH
11:22:59.894 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.897 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.899 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.901 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:22:59.902 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.903 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 9: Application update request. Node information received.
11:22:59.904 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class ASSOCIATION_GROUP_INFO
11:22:59.906 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class FIRMWARE_UPDATE_MD
11:22:59.906 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is awake with 0 messages in the wake-up queue.
11:22:59.907 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
11:22:59.909 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveWakeUpEvent
11:22:59.910 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.910 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: queue length(1), free to send(false)
11:22:59.911 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Initialisation retry timer started 10000
11:22:59.911 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - MANUFACTURER try 3: stageAdvanced(false)
11:22:59.912 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: MANUFACTURER - send ManufacturerSpecific
11:22:59.912 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 9: Creating new message for command MANUFACTURER_SPECIFIC_GET
11:22:59.914 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.916 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3219. Queue={}
11:22:59.917 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.917 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(1), free to send(false)
11:22:59.918 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 3: stageAdvanced(false)
11:22:59.918 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.919 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.920 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3220. Queue={}
11:22:59.921 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Wakeup during initialisation.
11:22:59.923 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(1), free to send(false)
11:22:59.923 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 3: stageAdvanced(false)
11:22:59.924 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.925 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.926 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3221. Queue={}
11:22:59.928 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.930 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:22:59.931 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=0, expected=ApplicationUpdate, cancelled=false        transaction complete!
11:22:59.932 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
11:22:59.933 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - MANUFACTURER: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.934 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.935 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.935 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.937 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.938 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.938 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 4: stageAdvanced(false)
11:22:59.938 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.939 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.939 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3222. Queue={}
11:22:59.940 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)
11:22:59.941 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - checking initialisation queue. Queue size 1.
11:22:59.942 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - message removed from queue. Queue size 0.
11:22:59.943 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - DETAILS: queue length(0), free to send(true)
11:22:59.943 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: loop - DETAILS try 4: stageAdvanced(false)
11:22:59.944 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer: DETAILS - send RequestNodeInfo
11:22:59.945 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 9: Node advancer - queued packet. Queue length is 1
11:22:59.946 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3223. Queue={}
11:22:59.946 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 418ms/1862ms.
11:22:59.947 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3222
11:22:59.948 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 09 92 
11:22:59.948 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 09 92 
11:22:59.958 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B 
11:22:59.959 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:22:59.961 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B 
11:22:59.962 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B 
11:22:59.962 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:59.963 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.
11:22:59.964 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent message Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, payload=09 
11:22:59.966 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv message Message: class=RequestNodeInfo[0x60], type=Response[0x01], priority=High, dest=255, payload=01 
11:22:59.966 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, callback id=0, expected=ApplicationUpdate, cancelled=false      MISMATCH
11:23:00.195 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:23:00.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
11:23:00.200 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:23:00.201 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 18 00 49 84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A DB 
11:23:00.202 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, payload=84 09 12 04 21 01 5E 86 72 59 85 73 71 84 80 30 31 70 7A EF 5A 
11:23:00.203 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 9: Application update request. Node information received.
11:23:00.204 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class ASSOCIATION_GROUP_INFO
11:23:00.206 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Unsupported command class FIRMWARE_UPDATE_MD

Ah - yes, because it’s nothing to do with a specific option - it’s an attribute of the parameter in the same way as the maximum and minimum values are attributes of the parameter, not the option…

was solved with another restart

Wasn’t that one of the big things @Kai talked about in an interview; that textual files had a great value from backups, readability, possibility to change etc etc…I think was this one: https://www.youtube.com/watch?v=uM-nPPnctCg

I might be wrong about the way configuration parameters are handled for static devices - I’m not sure as I don’t use them. I’ve also found another recent breaking change in ESH that I’m trying to fix now that will cause association configuration to fail, so if @vespaman was configuring an association, then it might be due to that issue (although from the image, I don’t think this was the case?).

Note: Until the following issue is resolved, you can’t currently configure associations…

this Devolo Motion Sensor kept not working, although it was now with the correct name included…

only after I excluded and reincluded (as a new node) the thing it started to work.

Is there a possibility that a thing is actually somehow corrupt included?

During the first inclusion, there was a message in the log that said it didn’t include correctly, so yes, it wasn’t right…

The security classes need some work still to get them reliable, and also to improve the discovery process.

ok from your perspective the best way is then to exclude from the controller and reinclude? (just if it happens again)

Yes - for the security classes, for now at least this is required. I think there’s scope to improve the way this works in future, but it’s not top of the ‘to-do’ list :wink:.

an error I found in the logs (its not bothering me… so only if you are interested in it)

12:43:10.014 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
12:43:10.015 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0E 00 04 00 0C 08 32 02 01 44 00 00 00 00 84 
12:43:10.017 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0E 00 04 00 0C 08 32 02 01 44 00 00 00 00 84 
12:43:10.018 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, payload=00 0C 08 32 02 01 44 00 00 00 00 
12:43:10.019 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
12:43:10.019 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class METER
12:43:10.020 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 12: Received Meter Request
12:43:10.021 [ERROR] [ssage.ApplicationCommandMessageClass] - Error processing frame: Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, payload=00 0C 08 32 02 01 44 00 00 00 00  >> Attempt to read message payload out of bounds: Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, payload=00 0C 08 32 02 01 44 00 00 00 00  (11)
12:43:14.970 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Timeout while sending message. Requeueing - 0 attempts left!
12:43:14.971 [ERROR] [l.serialmessage.SendDataMessageClass] - NODE 12: Got an error while sending data. Resending message.

Well, I tried both associations and other configuration settings. I also added one device fully from UI/Habmin and that one I had no problem with ( even got the new “Pending” flag), but with the ones I have declared in my .items file, I got the red error. (I only tried about five random ones of them). Then I stopped.

But now I tested a few more - and Voila! It works on some items even though they are in my .items file. But going back to the example (node 37 configuration 5 → BASIC_SET) still gives me the error.
I then removed node 37 in my .items file, and restarted OH/refreshed habmin but still same outcome - the error.

It seams to be thing/node based.

Could it be that I have previously tried to change associations (maybe I did, I don’t remember) and this gets the thing in some half-broken mode?

Thanks - this is a new processing feature to trap this sort of errors.

No - the error with associations is trapped before any processing is done… I’m not sure how the config is handled for things defined in a text file but it sounds like it’s not 100% seemless yet…

@chris OK, I’m onto something here!

I opened the edit of the device in PaperUI, and there I don’t have the configuration setting in the exampe (5)! It jumped from 4 to 7.

I then went back to the device in Habmin, and changed 4 (into normally open):- No error!

I then checked the manual for my node 37, which clearly states that option 5 is as preseneted in HABmin.

in the latest zwave binding there is one issue that has really quite some impact

randomly after openhab restarts some nodea stop to update item states … even there is stuff incoming.

this is solved by restarting openhab … however can be challenging as one node might be ok but another is not receiving item states updates then,… and causes extensive testing evey node after restart :frowning:

13:21:56.938 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 1F 00 04 00 0B 19 8F 01 04 03 80 03 64 04 30 03 00 0A 05 31 05 03 01 2F 06 31 05 01 22 00 D2 7A 
13:21:56.943 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
13:21:56.945 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 1F 00 04 00 0B 19 8F 01 04 03 80 03 64 04 30 03 00 0A 05 31 05 03 01 2F 06 31 05 01 22 00 D2 7A 
13:21:56.947 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 1F 00 04 00 0B 19 8F 01 04 03 80 03 64 04 30 03 00 0A 05 31 05 03 01 2F 06 31 05 01 22 00 D2 7A 
13:21:56.948 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, payload=00 0B 19 8F 01 04 03 80 03 64 04 30 03 00 0A 05 31 05 03 01 2F 06 31 05 01 22 00 D2 
13:21:56.949 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 11: Application Command Request (ALIVE:DETAILS)
13:21:56.950 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 11: Incoming command class MULTI_CMD
13:21:56.950 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Received Multi-Command Request
13:21:56.951 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Incoming command class BATTERY
13:21:56.951 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Calling handleApplicationCommandRequest.
13:21:56.952 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 11: Received Battery Request
13:21:56.952 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 11: Battery report value = 100
13:21:56.953 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
13:21:56.954 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Incoming command class SENSOR_BINARY
13:21:56.954 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Calling handleApplicationCommandRequest.
13:21:56.955 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 11: Received Sensor Binary Request (v0)
13:21:56.955 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 11: Sensor Binary report, type=Unknown, value=0
13:21:56.958 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveBinarySensorValueEvent
13:21:56.958 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Incoming command class SENSOR_MULTILEVEL
13:21:56.959 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Calling handleApplicationCommandRequest.
13:21:56.959 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Received Sensor Multi Level Request
13:21:56.960 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Multi Level REPORT received
13:21:56.960 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Type = Luminance(3), Scale = 0
13:21:56.961 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Value = 47
13:21:56.962 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
13:21:56.964 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Incoming command class SENSOR_MULTILEVEL
13:21:56.964 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 11: Calling handleApplicationCommandRequest.
13:21:56.965 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Received Sensor Multi Level Request
13:21:56.965 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Multi Level REPORT received
13:21:56.966 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Type = Temperature(1), Scale = 0
13:21:56.967 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 11: Sensor Value = 21
13:21:56.968 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
13:21:56.968 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Transaction not completed: node address inconsistent.  lastSent=12, incoming=255

What device is this for? (sorry if you’ve said previously - this thread is wayyyy too long to find stuff).