@chris, I usually try to handle these things myself but I’m stumped.
I got a good deal on one of these four button zwave remotes. My hope is to be able to configure it to trigger some non-zwave rules in OH which looks like it should be possible based on the Nodon CRC 3100 example on the wiki. I also checked the zwave database online and the Minimote is there but I can’t tell if it is only for OH 2 or not yet included when 1.8.2 was released.
I included the Minimote in the network by pressing the inclusion button on my controller and then the “Join” button on the Minimote and the blue light indicated success.
When I look in Habmin it shows a new node as node 11 but all the device information is blank or “Unknown” though it shows reasonable command classes (CONTROLLER, REMOTE_CONTROLLER, PORTABLE_REMOTE_CONTROLLER). When I look in /var/lib/openhab/zwave I see that there is no node11.xml and in the log I see:
[.b.z.i.p.i.ZWaveNodeSerializer:141 ]- NODE 11: Error serializing from file: file does not exist.
Below I’ve pasted in a grep for “NODE 11” from my zwave debug logs and a link to the full zwave debug logs. But if I’m not mistaken the lack of a node.xml means it isn’t in the DB, right?
So do I need to upgrade to OH 2, pull the 1.x zwave binding from the nightly builds, or is something else more significant wrong?
Many thanks.
2016-04-09 09:22:42.454 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.455 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.455 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.456 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.456 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.457 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.457 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.458 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.458 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.458 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.475 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.476 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.476 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.476 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.477 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.478 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.478 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.478 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.479 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.480 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.480 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.480 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.545 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.546 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.547 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.547 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:42.551 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button4
2016-04-09 09:22:42.552 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button1
2016-04-09 09:22:42.553 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button3
2016-04-09 09:22:42.553 [DEBUG] [.z.internal.ZWaveActiveBinding:188 ]- NODE 11: Polling list: can't get node for item Controller1_Button2
2016-04-09 09:22:44.980 [INFO ] [rialApiGetInitDataMessageClass:57 ]- NODE 11: Node found
2016-04-09 09:22:45.010 [DEBUG] [b.z.i.protocol.ZWaveController:493 ]- NODE 11: Init node thread start
2016-04-09 09:22:45.125 [DEBUG] [.b.z.i.p.i.ZWaveNodeSerializer:138 ]- NODE 11: Serializing from file /var/lib/openhab/zwave/node11.xml
2016-04-09 09:22:45.131 [DEBUG] [.b.z.i.p.i.ZWaveNodeSerializer:141 ]- NODE 11: Error serializing from file: file does not exist.
2016-04-09 09:22:45.147 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:269 ]- NODE 11: Node advancer - EMPTYNODE: queue length(0), free to send(true)
2016-04-09 09:22:45.153 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - EMPTYNODE try 1: stageAdvanced(false)
2016-04-09 09:22:45.153 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:340 ]- NODE 11: Node advancer: Initialisation starting
2016-04-09 09:22:45.154 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:868 ]- NODE 11: Node advancer - advancing to PROTOINFO
2016-04-09 09:22:45.159 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - PROTOINFO try 0: stageAdvanced(true)
2016-04-09 09:22:45.163 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:349 ]- NODE 11: Node advancer: PROTOINFO - send IdentifyNode
2016-04-09 09:22:45.164 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:242 ]- NODE 11: Node advancer - queued packet. Queue length is 1
2016-04-09 09:22:45.164 [DEBUG] [b.z.i.protocol.ZWaveController:585 ]- NODE 11: Init node thread finished
2016-04-09 09:22:45.249 [DEBUG] [i.p.s.IdentifyNodeMessageClass:52 ]- NODE 11: ProtocolInfo
2016-04-09 09:22:45.249 [DEBUG] [i.p.s.IdentifyNodeMessageClass:68 ]- NODE 11: Listening = false
2016-04-09 09:22:45.249 [DEBUG] [i.p.s.IdentifyNodeMessageClass:69 ]- NODE 11: Routing = false
2016-04-09 09:22:45.249 [DEBUG] [i.p.s.IdentifyNodeMessageClass:70 ]- NODE 11: Beaming = true
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:71 ]- NODE 11: Version = 3
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:72 ]- NODE 11: FLIRS = false
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:73 ]- NODE 11: Security = false
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:74 ]- NODE 11: Max Baud = 40000
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:89 ]- NODE 11: Basic = Controller
2016-04-09 09:22:45.250 [DEBUG] [i.p.s.IdentifyNodeMessageClass:96 ]- NODE 11: Generic = Remote Controller
2016-04-09 09:22:45.251 [DEBUG] [i.p.s.IdentifyNodeMessageClass:103 ]- NODE 11: Specific = Portable Remote Controller
2016-04-09 09:22:45.251 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:225 ]- NODE 11: Creating new instance of command class NO_OPERATION
2016-04-09 09:22:45.251 [DEBUG] [.z.internal.protocol.ZWaveNode:571 ]- NODE 11: Adding command class NO_OPERATION to the list of supported command classes.
2016-04-09 09:22:45.251 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:225 ]- NODE 11: Creating new instance of command class BASIC
2016-04-09 09:22:45.252 [DEBUG] [.z.internal.protocol.ZWaveNode:571 ]- NODE 11: Adding command class BASIC to the list of supported command classes.
2016-04-09 09:22:45.253 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:1013]- NODE 11: Node advancer - PROTOINFO: Transaction complete (IdentifyNode:Request) success(true)
2016-04-09 09:22:45.254 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:203 ]- NODE 11: Node advancer - checking initialisation queue. Queue size 1.
2016-04-09 09:22:45.254 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:209 ]- NODE 11: Node advancer - message removed from queue. Queue size 0.
2016-04-09 09:22:45.254 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:269 ]- NODE 11: Node advancer - PROTOINFO: queue length(0), free to send(true)
2016-04-09 09:22:45.255 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - PROTOINFO try 1: stageAdvanced(false)
2016-04-09 09:22:45.255 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:868 ]- NODE 11: Node advancer - advancing to NEIGHBORS
2016-04-09 09:22:45.255 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - NEIGHBORS try 0: stageAdvanced(true)
2016-04-09 09:22:45.255 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:359 ]- NODE 11: Node advancer: NEIGHBORS - send RoutingInfo
2016-04-09 09:22:45.255 [DEBUG] [p.s.GetRoutingInfoMessageClass:29 ]- NODE 11: Request routing info
2016-04-09 09:22:45.256 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:242 ]- NODE 11: Node advancer - queued packet. Queue length is 1
2016-04-09 09:22:45.381 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:45.385 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:45.385 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:45.385 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation
2016-04-09 09:22:45.411 [DEBUG] [p.s.GetRoutingInfoMessageClass:47 ]- NODE 11: Got NodeRoutingInfo request.
2016-04-09 09:22:45.411 [DEBUG] [p.s.GetRoutingInfoMessageClass:71 ]- NODE 11: No neighbors reported
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:1013]- NODE 11: Node advancer - NEIGHBORS: Transaction complete (GetRoutingInfo:Request) success(true)
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:203 ]- NODE 11: Node advancer - checking initialisation queue. Queue size 1.
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:209 ]- NODE 11: Node advancer - message removed from queue. Queue size 0.
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:269 ]- NODE 11: Node advancer - NEIGHBORS: queue length(0), free to send(true)
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - NEIGHBORS try 1: stageAdvanced(false)
2016-04-09 09:22:45.412 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:868 ]- NODE 11: Node advancer - advancing to FAILED_CHECK
2016-04-09 09:22:45.413 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - FAILED_CHECK try 0: stageAdvanced(true)
2016-04-09 09:22:45.413 [DEBUG] [i.p.s.IsFailedNodeMessageClass:31 ]- NODE 11: Requesting IsFailedNode status from controller.
2016-04-09 09:22:45.413 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:242 ]- NODE 11: Node advancer - queued packet. Queue length is 1
2016-04-09 09:22:45.490 [DEBUG] [i.p.s.IsFailedNodeMessageClass:54 ]- NODE 11: Is currently marked as healthy by the controller
2016-04-09 09:22:45.491 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:1013]- NODE 11: Node advancer - FAILED_CHECK: Transaction complete (IsFailedNodeID:Request) success(true)
2016-04-09 09:22:45.491 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:203 ]- NODE 11: Node advancer - checking initialisation queue. Queue size 1.
2016-04-09 09:22:45.491 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:209 ]- NODE 11: Node advancer - message removed from queue. Queue size 0.
2016-04-09 09:22:45.491 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:269 ]- NODE 11: Node advancer - FAILED_CHECK: queue length(0), free to send(true)
2016-04-09 09:22:45.492 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - FAILED_CHECK try 1: stageAdvanced(false)
2016-04-09 09:22:45.492 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:868 ]- NODE 11: Node advancer - advancing to WAIT
2016-04-09 09:22:45.492 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:335 ]- NODE 11: Node advancer: loop - WAIT try 0: stageAdvanced(true)
2016-04-09 09:22:45.492 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:382 ]- NODE 11: Node advancer: WAIT - Listening=false, FrequentlyListening=false
2016-04-09 09:22:45.492 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:400 ]- NODE 11: Node advancer: WAIT - Still waiting!
2016-04-09 09:22:46.071 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:46.072 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:46.072 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:46.072 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation
2016-04-09 09:22:46.377 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:46.378 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:46.378 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:46.379 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation
2016-04-09 09:22:46.554 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:46.555 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:46.555 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:46.555 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation
2016-04-09 09:22:46.601 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:999 ]- NODE 11: Node advancer - WAIT: The WAIT is over!
2016-04-09 09:22:46.601 [DEBUG] [z.i.p.i.ZWaveNodeStageAdvancer:203 ]- NODE 11: Node advancer - checking initialisation queue. Queue size 0.
2016-04-09 09:22:46.657 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:46.657 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:46.658 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:46.658 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation
2016-04-09 09:22:48.245 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button4 is not completed initialisation
2016-04-09 09:22:48.246 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button1 is not completed initialisation
2016-04-09 09:22:48.246 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button3 is not completed initialisation
2016-04-09 09:22:48.246 [DEBUG] [.z.internal.ZWaveActiveBinding:192 ]- NODE 11: Polling list: item Controller1_Button2 is not completed initialisation