New binding: Isy

great. thanks for pointing that out.

So, I deleted all existing isy things that had been discovered and uninstalled the Marketplace binding, then downloaded and installed the snapshot above on a whim. Then started openhab2 and the log reports this:

2017-06-05 16:00:13.715 [DEBUG] [sy.internal.IsyWebSocketSubscription] - in finally in IsyWebSocketSubscription
2017-06-05 16:00:13.722 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0" encoding="UTF-8"?><SubscriptionResponse><SID>uuid:1885</SID><duration>0</duration></SubscriptionResponse>
2017-06-05 16:00:14.422 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: , Action: , Node: 
2017-06-05 16:00:14.425 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="0" sid="uuid:1885"><control>_4</control><action>5</action><node></node><eventInfo><status>0</status></eventInfo></Event>
2017-06-05 16:00:14.475 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _4, Action: 5, Node: 
2017-06-05 16:00:16.758 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="1" sid="uuid:1885"><control>_4</control><action>6</action><node></node><eventInfo><status>1</status></eventInfo></Event>
2017-06-05 16:00:16.784 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _4, Action: 6, Node: 
2017-06-05 16:00:16.788 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="2" sid="uuid:1885"><control>_21</control><action>1.3</action><node></node><eventInfo><zwave nodeid="1" primary="true" suc="false" sis="false" networkEmpty="false" connected="true" extAntenna="true" keyProtected="true" autosleep="true" nodeFreeze="true" /></eventInfo></Event>
2017-06-05 16:00:16.844 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _21, Action: 1.3, Node: 
2017-06-05 16:00:16.847 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="3" sid="uuid:1885"><control>_1</control><action>8</action><node></node><eventInfo>6E30233D.EF04</eventInfo></Event>
2017-06-05 16:00:16.875 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _1, Action: 8, Node: 
2017-06-05 16:00:16.878 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="4" sid="uuid:1885"><control>_0</control><action>120</action><node></node><eventInfo></eventInfo></Event>
2017-06-05 16:00:16.902 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _0, Action: 120, Node: 
2017-06-05 16:00:16.904 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="5" sid="uuid:1885"><control>_19</control><action>6</action><node></node><eventInfo><se type="156" val="1" /></eventInfo></Event>
2017-06-05 16:00:16.922 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 6, Node: 
2017-06-05 16:00:16.925 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="6" sid="uuid:1885"><control>_19</control><action>6</action><node></node><eventInfo><se type="157" val="1" /></eventInfo></Event>
2017-06-05 16:00:16.947 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 6, Node: 
2017-06-05 16:00:16.950 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="7" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="1" val="0" /></eventInfo></Event>
2017-06-05 16:00:16.973 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:16.975 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="8" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="1" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.008 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.010 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="9" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="1" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.062 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.109 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="10" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="2" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.160 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.164 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="11" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="2" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.233 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.237 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="12" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="2" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.272 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.277 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="13" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="3" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.330 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.332 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="14" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="3" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.368 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.372 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="15" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="3" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.437 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.439 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="16" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="4" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.465 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.469 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="17" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="4" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.508 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.510 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="18" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="4" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.529 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.531 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="19" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="5" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.548 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.550 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="20" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="5" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.565 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.567 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="21" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="5" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.581 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.583 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="22" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="6" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.598 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.600 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="23" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="6" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.615 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.616 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="24" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="6" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.632 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.634 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="25" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="7" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.649 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.650 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="26" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="7" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.664 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.666 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="27" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="7" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.680 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.682 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="28" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="1" area="8" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.696 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.698 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="29" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="3" area="8" val="0" /></eventInfo></Event>
2017-06-05 16:00:17.712 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.713 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="30" sid="uuid:1885"><control>_19</control><action>2</action><node></node><eventInfo><ae type="2" area="8" val="1" /></eventInfo></Event>
2017-06-05 16:00:17.728 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: _19, Action: 2, Node: 
2017-06-05 16:00:17.729 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="31" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">28</action><node>2A 43 78 1</node><eventInfo></eventInfo><fmtAct>28</fmtAct></Event>
2017-06-05 16:00:17.804 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 28, Node: 2A 43 78 1
2017-06-05 16:00:17.805 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 43 78 1
2017-06-05 16:00:17.833 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 43 78
2017-06-05 16:00:17.835 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 43 78 1
2017-06-05 16:00:17.836 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="32" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 43 78 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:17.851 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 43 78 1
2017-06-05 16:00:17.852 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 43 78 1
2017-06-05 16:00:17.854 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 43 78
2017-06-05 16:00:17.855 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 43 78 1
2017-06-05 16:00:17.857 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="33" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 43 78 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:17.880 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 43 78 1
2017-06-05 16:00:17.882 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 43 78 1
2017-06-05 16:00:17.883 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 43 78
2017-06-05 16:00:17.885 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 43 78 1
2017-06-05 16:00:17.887 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="34" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">28</action><node>2A 57 95 1</node><eventInfo></eventInfo><fmtAct>28</fmtAct></Event>
2017-06-05 16:00:17.901 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 28, Node: 2A 57 95 1
2017-06-05 16:00:17.902 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 57 95 1
2017-06-05 16:00:17.904 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 57 95
2017-06-05 16:00:17.905 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 57 95 1
2017-06-05 16:00:17.919 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="35" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 57 95 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:17.933 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 57 95 1
2017-06-05 16:00:17.958 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 57 95 1
2017-06-05 16:00:17.959 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 57 95
2017-06-05 16:00:17.961 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 57 95 1
2017-06-05 16:00:17.962 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="36" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 57 95 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:18.008 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 57 95 1
2017-06-05 16:00:18.010 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 57 95 1
2017-06-05 16:00:18.023 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 57 95
2017-06-05 16:00:18.024 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 57 95 1
2017-06-05 16:00:18.026 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="37" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">31</action><node>2A 5A 9E 1</node><eventInfo></eventInfo><fmtAct>31</fmtAct></Event>
2017-06-05 16:00:18.039 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 31, Node: 2A 5A 9E 1
2017-06-05 16:00:18.041 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 5A 9E 1
2017-06-05 16:00:18.043 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 5A 9E
2017-06-05 16:00:18.044 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 5A 9E 1
2017-06-05 16:00:18.046 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="38" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 5A 9E 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:18.059 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 5A 9E 1
2017-06-05 16:00:18.060 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 5A 9E 1
2017-06-05 16:00:18.062 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 5A 9E
2017-06-05 16:00:18.063 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 5A 9E 1
2017-06-05 16:00:18.065 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="39" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 5A 9E 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:18.098 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 5A 9E 1
2017-06-05 16:00:18.100 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 5A 9E 1
2017-06-05 16:00:18.102 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 5A 9E
2017-06-05 16:00:18.104 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 5A 9E 1
2017-06-05 16:00:18.106 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="40" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">31</action><node>2A 60 7 1</node><eventInfo></eventInfo><fmtAct>31</fmtAct></Event>
2017-06-05 16:00:18.134 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 31, Node: 2A 60 7 1
2017-06-05 16:00:18.136 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 60 7 1
2017-06-05 16:00:18.137 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 60 7
2017-06-05 16:00:18.139 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 60 7 1
2017-06-05 16:00:18.140 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="41" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 60 7 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:18.151 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 60 7 1
2017-06-05 16:00:18.153 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 60 7 1
2017-06-05 16:00:18.154 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 60 7
2017-06-05 16:00:18.155 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 60 7 1
2017-06-05 16:00:18.156 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="42" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 60 7 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:18.168 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 60 7 1
2017-06-05 16:00:18.169 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 60 7 1
2017-06-05 16:00:18.170 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 60 7
2017-06-05 16:00:18.171 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 60 7 1
2017-06-05 16:00:18.172 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="43" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">31</action><node>2A 62 40 1</node><eventInfo></eventInfo><fmtAct>31</fmtAct></Event>
2017-06-05 16:00:18.184 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 31, Node: 2A 62 40 1
2017-06-05 16:00:18.185 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 62 40 1
2017-06-05 16:00:18.186 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 62 40
2017-06-05 16:00:18.187 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 62 40 1
2017-06-05 16:00:18.189 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="44" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 62 40 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:18.200 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 62 40 1
2017-06-05 16:00:18.202 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 62 40 1
2017-06-05 16:00:18.203 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 62 40
2017-06-05 16:00:18.204 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 62 40 1
2017-06-05 16:00:18.205 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="45" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 62 40 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:18.216 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 62 40 1
2017-06-05 16:00:18.218 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 62 40 1
2017-06-05 16:00:18.219 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 62 40
2017-06-05 16:00:18.220 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 62 40 1
2017-06-05 16:00:18.221 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="46" sid="uuid:1885"><control>RR</control><action uom="25" prec="0">31</action><node>2A 53 A 1</node><eventInfo></eventInfo><fmtAct>31</fmtAct></Event>
2017-06-05 16:00:18.232 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: RR, Action: 31, Node: 2A 53 A 1
2017-06-05 16:00:18.234 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 53 A 1
2017-06-05 16:00:18.235 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 53 A
2017-06-05 16:00:18.237 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 53 A 1
2017-06-05 16:00:18.238 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="47" sid="uuid:1885"><control>OL</control><action uom="100" prec="0">255</action><node>2A 53 A 1</node><eventInfo></eventInfo><fmtAct>100%</fmtAct></Event>
2017-06-05 16:00:18.249 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: OL, Action: 255, Node: 2A 53 A 1
2017-06-05 16:00:18.250 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 53 A 1
2017-06-05 16:00:18.252 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 53 A
2017-06-05 16:00:18.253 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 53 A 1
2017-06-05 16:00:18.254 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="48" sid="uuid:1885"><control>ST</control><action uom="100" prec="0">0</action><node>2A 53 A 1</node><eventInfo></eventInfo><fmtAct>0%</fmtAct></Event>
2017-06-05 16:00:18.300 [DEBUG] [sy.internal.IsyWebSocketSubscription] - Control: ST, Action: 0, Node: 2A 53 A 1
2017-06-05 16:00:18.301 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - find thing handler for address: 2A 53 A 1
2017-06-05 16:00:18.302 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - Find thing for address: 2A 53 A
2017-06-05 16:00:18.303 [DEBUG] [binding.isy.handler.IsyBridgeHandler] - No thing discovered for address: 2A 53 A 1
2017-06-05 16:00:18.305 [TRACE] [sy.internal.IsyWebSocketSubscription] - Parsing message: <?xml version="1.0"?><Event seqnum="49" sid="uuid:1885"><control>CLIHCS</control><action uom="66" prec="0">0</action><node>ZW008_1</node><eventInfo></eventInfo><fmtAct>Idle</fmtAct></Event>

For instance the first device reporting no thing discovered (2A 43 78) is (from the isy network list) ā€œMaster Suite / Ensuite Fan Off 2A 43 78 1 (2477S) Dual Band SwitchLinc On/Off Switch v.43ā€. It is one of many that do not appear during discovery. After that I ran a discovery, but it appeared the same as in my earlier posting - no info at all about the missing devices.
Hope this is of some use.

Could you leave it at TRACE level and run discovery, and send those logs. What you are showing is what I would expect for devices which do not have things created within openhab. Need to figure out why discovery isnā€™t creating such things.

The bug could be something like a character in your item names I donā€™t handle correctly (i.e. /), or could be to do with zwave, just not sure.

Thanks Craig. Here is a link to the log: https://www.dropbox.com/s/pbt4k19b51zo19r/isycapture.log?dl=0
Itā€™s too large to paste in here.

Gordon

ok. If you could get the latest version and re-run your discovery it
should find your insteon devices. I have a feeling your polygot nodes
crashed discovery. Discovery should now ignore those nodes, and not crash.

You also have some unsupported insteon nodes. Look for log lines which
start with: ā€˜Unsupported insteon nodeā€™. If you could go through those lines
and let me know what type they should be mapped to, I can add support.
There wonā€™t be support for all node types at this time, for instance it
looks like you have a thermostat there.

That seems to have done it. The list of unsupported nodes is below. The thermostats are all ZWave though, not Insteon.

Unsupported insteon node, name: Shower Floods, type: 01.24, address: 3D E6 FF 1 - Insteon (2474DWH) SwitchLinc Dimmer 2-Wire v.42
Unsupported insteon node, name: Media Room Remote, type: 00.11, address: 26 23 31 1 - Insteon (2342-242) RemoteLinc 2 Switch v.37
Unsupported insteon node, name: Irrigation _ Front Shrub Beds, type: 04.00, address: 21 2D D8 - EZRain/EZFlora Irrigation Controller v.28
Unsupported insteon node, name: EZIO2X4.1, type: 07.03, address: 28 AE 29 1 - Compacta EZIO 2x4: INSTEON I/O Controller v.FF
Unsupported insteon node, name: Hallway Remote, type: 02.2C, address: 24 EE B0 1 - Insteon (2487S) Dual Band KeypadLinc Relay v.41

Thanks,
Gordon

Perhaps Iā€™m not understanding how to use the channels correctly. I added a switch widget in habpanel using the status channel of one of my switches. When I toggle it in the panel, it changes state on the display and sends a DON/0 to the device in the isy. The DON/0 is sent whether the toggle is on or off. (I used tshark to capture the i/o from openhab to the isy) If I manually make a rest call from a browser, sending a DON/1 or just DON with no suffix turns on the device and a DON/0 or a DOF/0 turns it off. Am I missing something?

Gordon

Iā€™m not sure there is a status channel for any of the devices.

Have you tried looking at the paperui, specifically the control option on the left? Try clicking one of the switches on that page.

Could you send me the sitemap line you use, maybe I can see from your item name what is going wrong.

Have you logged in to Karaf yet? using the smarthome:things, smarthome:items, smarthome:links commands help create an understanding of how openhab manages things.

Thanks Craig.
My bad, I meant ā€œStateā€ channel. I have tried the PaperUI control interface as well as the Basic UI default interface with the same results. It was my understanding based on the habpanel docs that habpanel neither required or used sitemaps, so I havenā€™t written one. And yes, I am familiar with the Karaf console. The items, links and things listed there for the particular switch Iā€™m experimenting with all ā€œseemā€ ok.

thing - isy:switch:f75c62c0:2A_40_99 (Type=Thing, Status=ONLINE, Label=Upper Hall Master, Bridge=isy:isyBridge:f75c62c0) 
item - isy_switch_f75c62c0_2A_40_99_state (Type=SwitchItem, State=OFF, Label=Off/On, Category=Switch)
links - isy_switch_f75c62c0_2A_40_99_state -> isy:switch:f75c62c0:2A_40_99:state```

Anyway, I'll keep experimenting with it.
Cheers

Does your switch turn on if you go into Karaf and enter:

smarthome:update Isy_switch_f75c62c0_2A_40_99_state ON

Check for typos, I didnā€™t have copy/paste avail and just typed in your item
Id

Well, something sort of happens.

openhab> smarthome:update isy_switch_f75c62c0_2A_40_99_state ON
Update has been sent successfully

The state changes in the UI displays (all of them) and this shows in the log in Karaf:

07:49:24.831 [INFO ] [marthome.event.ItemStateChangedEvent] - isy_switch_f75c62c0_2A_40_99_state changed from OFF to ON```

However, no command is sent to the isy that I can see on the tshark trace.

One note, if the device is already on, it will turn off through any of the UI's.  The command from Karaf does nothing in either state.
Could this have something to do either with isy 5.0.10 or that I'm running the latest openHAB snapshot?

Gordon,

I have increased the logging in another spot. Could you update your binding and try to turn on switch and check the logs?

I believe there will still be issues, could we move this over to my GitHub so the change can be tracked and we keep this posting from getting crazy long?

Here is a link to create the issue: https://github.com/QuailAutomation/openhab2-addons/issues/

thanks,
craig

ps. I have a feeling it may have to do with the v 5.x of the isy firmware, but not sure just yet.

Done. Issue #10.

Just to close off here, thanks for your attention on this! Looks like the problem is solved. Much appreciated. Iā€™ve closed the problem on github.

good to hear. thanks for helping to get it worked out. when you find more
issues feel free to add issues to my GitHub repository.

cheers,
craig

@craigh I just upgraded to OH 2.1 and installed the Eclipse IoT Market binding. See that there is an ISY binding listed there. Is this your binding? If so, is the current version in the IoT Market or should I continue to use the one hosted at amazonaws?

Thanks!

Yes that always retrieves the latest version.

Hi Craigh,

First off; great job on this binding! Iā€™ve been using an ISY 99i for about 8 years now (just realized that its been quite a while!!!). Although I assume your binding aims at users of the newer models; so far I have found a good level of compatibility with my setup.

A few devices that I have are however turning up as unrecognized; these are ICON insteon dimmers, model number 2876DB Icon Dimmer v.39 (From ISYā€™s web UI info). The ID pulled by the binding is : 01.1E

As a semi work around, I have created some scenes in the ISY and these are recognized by the Binding; it allows me to turn lights on and off, but lacks the dimmer features.

Also last quick bit: When I change the state of a dimmer outside OpenHAB; it does not update in openHAB. Example: I set a dimmer at 50% in Paper UI or HAB Panel; walk to the dimmer; set it to 100%. The dimmer does go to 100%, but in openHAB (Paper UI or HABPanel) it stays at 50%. Refreshing the browser doesnā€™t update the value either.

FYI: Iā€™m using the ISY 99i with Insteon devices as well as an ELK alarm system. I do not think you have worked on any of the ELK integration yet, but if you plan to; let me know! Otherwise I may be interested in helping out developing that side of the ISY starting with your Binding. Using the ELK Alarm sensors has been pretty neat as triggers to my Insteon controlled devices; if we could combine all of this in OpenHAB, it would be terrific!

Anyways; thanks again for an already very useful binding!

Cheers,
Francis

Amazing work on this! I have used the ISY for a while now and wanted to get a mqtt working with it so I thought your binding might be my best path.

While I have mqtt working for ISY actions initiated form within OpenHAB (i.e. clicking on a software switch to trigger my Insteon dimmer to turn off or on), but whenever I use the physical Insteon switch, I donā€™t get mqtt updates from that action - even though the software switchin within OpenHAB moves in sync.

Sorry for such a noob question, but how can I get OpenHAB to report the mqtt status whenever I trigger a change from an Insteon device - rather than from within OpenHAB?

Thanks very much.

EDIT
Below is .items entry.

Switch mySwitch4 {channel=ā€œisy:dimmer:MyISY:1D_D3_3:loadlevelā€, mqtt=">[broker:/office/light4:command:ON:1],>[broker:/office/light4:command:OFF:0]"}

Hi Jim,

Sorry, but I donā€™t have an answer for you.

I would post this question on its own topic and you should get help to pass things on to mqtt.