Vision ZL 7432 In-Wall Switch, 2 Relays

I have successfully installed one of these switches on two toggle switches. I can control the lights attached no issue but when I use the wall switch itself to control the light the status of the light and the item state of that switch does not change. I suspect I have to monitor some other item that is linked to the individual switches but I can’t seem to figure out what the documentation is telling me. Referring to point #3 in the installation instructions it says:

For Wall SW1, ZL 7432 will report the status of On/OFF after doing “Association”.   However, Wall SW2 will only report the status if Z-Wave™ Interface Controller support Multi Channel command, and send Get Command to ask ZL 7432 Wall SW 2 to report the status.

What do they mean about doing “Association”? And for switch#2, from what I have read in the Wiki I think the z-wave binding supports “Multi Channel”.

My bindings are very straight forward:

Switch    Front_Outdoor_Light    "Front Outdoor Lights"        <light>    (main)        {zwave="5:1:command=switch_binary"}
Switch    Foyer_Light                "Foyer Light"                    <light>    (main)        {zwave="5:2:command=switch_binary"}

I did find another discussion on this dual relay here. It appears to be unresolved unfortunately. I noticed that @chris was part of that discussion. I’m not sure I would be able to contribute as I’m a bit of a newbie at this, but I’d be willing to experiment with some guidance.

I still have an issue with this dual switch. Here is the openhab.log file with debug turned on. I pared it down to just the lines that I think someone with intimate knowledge of the zwave binding would be interested in. Based on it I was hoping that the zwave binding author(s) may be able to figure out how to report the information about when the manual toggle switch is operated. I assume this could be incorporate it in the binding in some way so the interface indicator of the light being on or off would reflex the actual state of the light. I did add a few comment lines in the log file that indicate the different sections.

For both switches I started with the light off. I turned it on then off via the openhab web interface. Next I turned it on then off with the physical wall switch. Whoever looks at this let me know if you need something else.

(Note: I ran into a posting length limit so the next post will be the log for the second switch.)


---------------------------------------------------------------------------------------------------------------------------------------------------------------
--------------------- Switch    Front_Outdoor_Light    "Front Outdoor Lights"    <light>    (gMain, gFrontOutdoorLights)    {zwave="5:1:command=switch_binary"}
---------------------------------------------------------------------------------------------------------------------------------------------------------------
-------------- used openhab interface to turn light on
13:10:27.039 [DEBUG] [o.i.r.i.resources.ItemResource:193  ] - Received HTTP POST request at 'items/Front_Outdoor_Light' with value 'ON'.
13:10:27.040 [DEBUG] [.ZWaveBinarySwitchCommandClass:146  ] - NODE 5: Creating new message for application command SWITCH_BINARY_SET
13:10:27.040 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 5: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:10:27.040 [DEBUG] [.z.internal.protocol.ZWaveNode:623  ] - NODE 5: Encapsulating message, instance / endpoint 1
13:10:27.040 [DEBUG] [ZWaveMultiInstanceCommandClass:560  ] - NODE 5: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 1
13:10:27.040 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 21
13:10:27.040 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:10:27.040 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:10:27.041 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0E 00 13 05 07 60 0D 01 01 25 01 FF 25 15 66 
13:10:27.041 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 5: Sending REQUEST Message = 01 0E 00 13 05 07 60 0D 01 01 25 01 FF 25 15 66 
13:10:27.049 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:10:27.049 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:27.049 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:27.049 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:10:27.049 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:10:27.049 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:10:27.049 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 5: Sent Data successfully placed on stack.
13:10:27.067 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 07 00 13 15 00 00 02 FC 
13:10:27.067 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:27.067 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:27.067 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 09 00 13 15 00 00 02 00 00 F2 
13:10:27.067 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 09 00 13 15 00 00 02 00 00 F2 
13:10:27.067 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Request (0x00), payload = 15 00 00 02 
13:10:27.068 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74   ] - NODE 5: SendData Request. CallBack ID = 21, Status = Transmission complete and ACK received(0)
13:10:27.068 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 01 25 01 FF 
13:10:27.068 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 15 00 00 02 
13:10:27.068 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false
13:10:27.068 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68   ] -          transaction complete!
13:10:27.068 [DEBUG] [b.z.i.protocol.ZWaveController:595  ] - Notifying event listeners: ZWaveTransactionCompletedEvent
13:10:27.068 [DEBUG] [.z.internal.ZWaveActiveBinding:433  ] - ZwaveIncomingEvent
13:10:27.068 [DEBUG] [WaveController$ZWaveSendThread:1287 ] - NODE 5: Response processed after 27ms/1259ms.
13:10:27.358 [DEBUG] [o.o.i.r.i.b.GeneralBroadcaster:46   ] - broadcaster 'org.openhab.io.rest.internal.broadcaster.GeneralBroadcaster$1@16370e86' is empty
13:10:27.428 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:27.438 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:27.448 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
------------------------- used openhab interface to turn light off
13:10:35.140 [DEBUG] [o.i.r.i.resources.ItemResource:193  ] - Received HTTP POST request at 'items/Front_Outdoor_Light' with value 'OFF'.
13:10:35.141 [DEBUG] [.ZWaveBinarySwitchCommandClass:146  ] - NODE 5: Creating new message for application command SWITCH_BINARY_SET
13:10:35.141 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 5: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:10:35.141 [DEBUG] [.z.internal.protocol.ZWaveNode:623  ] - NODE 5: Encapsulating message, instance / endpoint 1
13:10:35.141 [DEBUG] [ZWaveMultiInstanceCommandClass:560  ] - NODE 5: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 1
13:10:35.141 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 22
13:10:35.141 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:10:35.141 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:10:35.142 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0E 00 13 05 07 60 0D 01 01 25 01 00 25 16 9A 
13:10:35.142 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 5: Sending REQUEST Message = 01 0E 00 13 05 07 60 0D 01 01 25 01 00 25 16 9A 
13:10:35.150 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:10:35.150 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:35.150 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:35.150 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:10:35.150 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:10:35.150 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:10:35.150 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 5: Sent Data successfully placed on stack.
13:10:35.167 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 07 00 13 16 00 00 02 FF 
13:10:35.168 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:35.168 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:35.168 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 09 00 13 16 00 00 02 00 00 F1 
13:10:35.168 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 09 00 13 16 00 00 02 00 00 F1 
13:10:35.168 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Request (0x00), payload = 16 00 00 02 
13:10:35.168 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74   ] - NODE 5: SendData Request. CallBack ID = 22, Status = Transmission complete and ACK received(0)
13:10:35.168 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 01 25 01 00 
13:10:35.168 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 16 00 00 02 
13:10:35.168 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false
13:10:35.168 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68   ] -          transaction complete!
13:10:35.168 [DEBUG] [b.z.i.protocol.ZWaveController:595  ] - Notifying event listeners: ZWaveTransactionCompletedEvent
13:10:35.168 [DEBUG] [.z.internal.ZWaveActiveBinding:433  ] - ZwaveIncomingEvent
13:10:35.168 [DEBUG] [WaveController$ZWaveSendThread:1287 ] - NODE 5: Response processed after 26ms/1259ms.
13:10:35.455 [DEBUG] [o.o.i.r.i.b.GeneralBroadcaster:46   ] - broadcaster 'org.openhab.io.rest.internal.broadcaster.GeneralBroadcaster$1@16370e86' is empty
13:10:35.508 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:35.563 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:35.590 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:36.995 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:10:37.384 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
----------------------------------  I believe this is the point where I flipped the physical switch on ***********************
13:10:40.297 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F
13:10:40.297 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:40.297 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:40.298 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:10:40.298 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:10:40.298 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:10:40.298 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:10:40.298 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:10:40.298 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:10:40.298 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:10:40.298 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:10:40.298 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:40.299 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:10:40.299 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:40.299 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:40.299 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:10:40.300 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:40.300 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:10:40.300 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 01 25 01 00 
13:10:40.300 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:10:40.300 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false
---------------------------- and this is the place where I turned the physical switch back off again *********************
13:10:45.965 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:10:45.965 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:45.965 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:45.965 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:10:45.966 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:10:45.966 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:10:45.966 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:10:45.966 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:45.966 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:10:45.966 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:10:45.966 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:45.967 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:10:45.967 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:45.967 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:10:45.967 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 01 25 01 00 
13:10:45.967 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:10:45.967 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false

Here is the second part of the log with the entries pertinent to the second relay in the unit.

---------------------------------------------------------------------------------------------------------------------------------------------------------------
--------------------- Switch    Foyer_Light    "Foyer Light"    <light>    (gMain, gFrontOutdoorLights)    {zwave="5:2:command=switch_binary"}
---------------------------------------------------------------------------------------------------------------------------------------------------------------
-------------- used openhab interface to turn light on
13:10:50.473 [DEBUG] [o.i.r.i.resources.ItemResource:193  ] - Received HTTP POST request at 'items/Foyer_Light' with value 'ON'.
13:10:50.474 [DEBUG] [.ZWaveBinarySwitchCommandClass:146  ] - NODE 5: Creating new message for application command SWITCH_BINARY_SET
13:10:50.474 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 5: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:10:50.474 [DEBUG] [.z.internal.protocol.ZWaveNode:623  ] - NODE 5: Encapsulating message, instance / endpoint 2
13:10:50.474 [DEBUG] [ZWaveMultiInstanceCommandClass:560  ] - NODE 5: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 2
13:10:50.474 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 23
13:10:50.474 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:10:50.474 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:10:50.474 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0E 00 13 05 07 60 0D 01 02 25 01 FF 25 17 67 
13:10:50.474 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 5: Sending REQUEST Message = 01 0E 00 13 05 07 60 0D 01 02 25 01 FF 25 17 67 
13:10:50.482 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:10:50.482 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:50.483 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:50.483 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:10:50.483 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:10:50.483 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:10:50.483 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 5: Sent Data successfully placed on stack.
13:10:50.500 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 07 00 13 17 00 00 02 FE 
13:10:50.501 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:50.501 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:50.501 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 09 00 13 17 00 00 02 00 00 F0 
13:10:50.501 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 09 00 13 17 00 00 02 00 00 F0 
13:10:50.501 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Request (0x00), payload = 17 00 00 02 
13:10:50.501 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74   ] - NODE 5: SendData Request. CallBack ID = 23, Status = Transmission complete and ACK received(0)
13:10:50.501 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 02 25 01 FF 
13:10:50.501 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 17 00 00 02 
13:10:50.501 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false
13:10:50.501 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68   ] -          transaction complete!
13:10:50.501 [DEBUG] [b.z.i.protocol.ZWaveController:595  ] - Notifying event listeners: ZWaveTransactionCompletedEvent
13:10:50.501 [DEBUG] [.z.internal.ZWaveActiveBinding:433  ] - ZwaveIncomingEvent
13:10:50.502 [DEBUG] [WaveController$ZWaveSendThread:1287 ] - NODE 5: Response processed after 28ms/1259ms.
13:10:50.798 [DEBUG] [o.o.i.r.i.b.GeneralBroadcaster:46   ] - broadcaster 'org.openhab.io.rest.internal.broadcaster.GeneralBroadcaster$1@16370e86' is empty
13:10:50.840 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:50.878 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:50.927 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
------------------------- used openhab interface to turn light off
13:10:56.694 [DEBUG] [o.i.r.i.resources.ItemResource:193  ] - Received HTTP POST request at 'items/Foyer_Light' with value 'OFF'.
13:10:56.694 [DEBUG] [.ZWaveBinarySwitchCommandClass:146  ] - NODE 5: Creating new message for application command SWITCH_BINARY_SET
13:10:56.695 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 5: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:10:56.695 [DEBUG] [.z.internal.protocol.ZWaveNode:623  ] - NODE 5: Encapsulating message, instance / endpoint 2
13:10:56.695 [DEBUG] [ZWaveMultiInstanceCommandClass:560  ] - NODE 5: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 2
13:10:56.695 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 24
13:10:56.695 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:10:56.695 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:10:56.695 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0E 00 13 05 07 60 0D 01 02 25 01 00 25 18 97 
13:10:56.695 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 5: Sending REQUEST Message = 01 0E 00 13 05 07 60 0D 01 02 25 01 00 25 18 97 
13:10:56.703 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:10:56.703 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:56.703 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:56.703 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:10:56.703 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:10:56.704 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:10:56.704 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 5: Sent Data successfully placed on stack.
13:10:56.721 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 07 00 13 18 00 00 02 F1 
13:10:56.721 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:56.721 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:56.721 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 09 00 13 18 00 00 02 00 00 FF 
13:10:56.722 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 09 00 13 18 00 00 02 00 00 FF 
13:10:56.722 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Request (0x00), payload = 18 00 00 02 
13:10:56.722 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74   ] - NODE 5: SendData Request. CallBack ID = 24, Status = Transmission complete and ACK received(0)
13:10:56.722 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 02 25 01 00 
13:10:56.722 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 18 00 00 02 
13:10:56.722 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false
13:10:56.722 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68   ] -          transaction complete!
13:10:56.722 [DEBUG] [b.z.i.protocol.ZWaveController:595  ] - Notifying event listeners: ZWaveTransactionCompletedEvent
13:10:56.722 [DEBUG] [.z.internal.ZWaveActiveBinding:433  ] - ZwaveIncomingEvent
13:10:56.722 [DEBUG] [WaveController$ZWaveSendThread:1287 ] - NODE 5: Response processed after 27ms/1259ms.
13:10:57.014 [DEBUG] [o.o.i.r.i.b.GeneralBroadcaster:46   ] - broadcaster 'org.openhab.io.rest.internal.broadcaster.GeneralBroadcaster$1@16370e86' is empty
13:10:57.086 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:57.098 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
13:10:57.113 [DEBUG] [.r.i.resources.SitemapResource:146  ] - Received HTTP GET request at 'sitemaps/copley/0000' for media type 'null'.
----------------------------------  I believe this is the point where I flipped the physical switch on ***********************
13:10:59.868 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:10:59.868 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:10:59.868 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:10:59.868 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:10:59.868 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:10:59.868 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:10:59.868 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:10:59.868 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:59.869 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:10:59.869 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:10:59.869 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:10:59.869 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:10:59.870 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:10:59.870 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:10:59.870 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:10:59.870 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 02 25 01 00 
13:10:59.870 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:10:59.870 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false
13:11:02.384 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:11:02.831 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
---------------------------- and this is the place where I turned the physical switch back off again *********************
13:11:04.218 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:11:04.219 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:11:04.219 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:11:04.219 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:11:04.219 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:11:04.219 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:11:04.219 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:11:04.219 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:11:04.219 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:11:04.219 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:11:04.220 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:11:04.220 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:11:04.220 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:11:04.220 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:11:04.220 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 07 60 0D 01 02 25 01 00 
13:11:04.220 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:11:04.220 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false
13:11:17.973 [DEBUG] [z.internal.ZWaveNetworkMonitor:341  ] - NODE 2: Sending periodic PING.
13:11:17.973 [DEBUG] [c.ZWaveNoOperationCommandClass:72   ] - NODE 2: Creating new message for command No Operation
13:11:17.973 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 2: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:11:17.973 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 25
13:11:17.973 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:11:17.973 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:11:17.973 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 08 00 13 02 01 00 25 19 DB 
13:11:17.973 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 2: Sending REQUEST Message = 01 08 00 13 02 01 00 25 19 DB 
13:11:17.980 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:11:17.980 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:11:17.980 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:11:17.980 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:11:17.981 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:11:17.981 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:11:17.981 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 2: Sent Data successfully placed on stack.

If I remember correctly, the issue here is that the device doesn’t send messages using the multi_instance class when the switch is manually changed. Therefore there is no way to distinguish between the two switches.

It’s hard to know what you’ve done with your logs - when exactly did you manually click on the switches…

OK I added a few separators to the posts above to indicate where I believe was the physical event of flipping the switches.

It appears to me that two different messages are being sent depending on which switch is thrown. The last byte in one case is 8F for SW1, and 8C for SW2. The messages however seem to be the same for both the on and off for the given switch. The documentation indicates that you can distinguish between the two. For SW1 you have to do an “Association”, whatever that is. For SW2 you need to “send Get Command to ask” the status.

Quote from instructions:
3. For Wall SW1, ZL 7432 will report the status of On/OFF after doing “Association”. However, Wall SW2 will only report the status if Z-Wave™ Interface Controller support Multi Channel command, and send Get Command to ask ZL 7432 Wall SW 2 to report the status.
4. Status of “ON”(Binary Switch Set 0xFF or wallswitch ON)
Status of “OFF”(Binary Switch Set 0x00 or wall switch OFF)

----------------------------------  I believe this is the point where I flipped the physical switch on ***********************
Switch 1 - 13:10:40.297 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F
Switch 2 - 13:10:59.868 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 

---------------------------- and this is the place where I turned the physical switch back off again *********************
Switch 1 - 13:10:45.965 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F
Switch 2 - 13:11:04.218 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 

The last byte is just the checksum, but you are right, these are multi instance messages and they do identify the endpoint.

However, this is a very strange message for the switch to send. The message is a capability report - not a status report. This report is normally only sent during device initialisation to say that it supports multi_instance messages, and how they are supported…

Are you REALLY sure that this is when you flicked the switch. There is a 5 second timeout within the binding, and if i look at both of your manual switches, they are nearly exactly 5 seconds for both which seems strange -:

Switch 1 on (13:10:40.297) and off (13:10:45.965) - 5.6 seconds
Switch 2 on (13:10:59.868) and off (13:11:04.218) - 5.3 seconds

Maybe your manual switch timing is just very good :slight_smile: but there are also other messages being sent around this time, so it would be good to be sure about what we’re looking at as it is a strange message to be sent as a notification (a notification that doesn’t provide status even).

What I did was start the system with an empty log and I went to the switches. I had my iPad with me and I cycled one switch via the iPad, then I toggled the physical switch. Then I repeated the process with the other switch. So the timing could be as close as it indicates. It was a few days ago so I don’t remember the exact timing I used. Any suggestions on how I should do another test? Maybe use a stop watch and vary the times that I toggle the switch.

The more I think about it the more I’m sure it is the points when I flipped the switch. But I will do another test to make absolutely sure and toggle them more than one cycle.

Thanks - I think it would be good to confirm. As I said, this is quite a strange notification for the switch to send and it would take a bodge to actually be able to able to use this to solve your problem :frowning:

I can confirm that those are the messages that are sent when the switch is toggled. I’m 100% sure. I just did another test, toggling SW1 twice at 10 second intervals, then SW2 at 20 second intervals. I got the same messages in the log as I had posted in the previous posts with the expected intervals between the events. From what you say it isn’t normal behaviour, but that is what I’m getting.

Ok - then please raise an issue with the above information. Since this is such a strange message for the switch to send it will take some thought about how to solve this and it will likely not be something that gets implemented soon…

Actually, can you also post the new log please - I just want to double check some things…

Here is the section of the log for SW1 toggling twice.

start SW1 on
13:42:29.853 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:29.853 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:29.853 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:29.853 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:29.853 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:29.853 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:29.853 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:42:29.853 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:42:29.853 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:42:29.853 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:42:29.853 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:42:29.853 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:42:29.853 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:29.854 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:42:29.854 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:29.854 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:29.855 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:29.855 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:42:29.855 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:29.855 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:42:29.855 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 01 00 
13:42:29.855 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:29.855 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false
SW 1 off
13:42:39.586 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:39.587 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:39.587 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:39.587 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:39.587 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:39.587 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:39.587 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:42:39.587 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:39.587 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:39.588 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:42:39.588 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:39.588 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:42:39.588 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:39.588 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:42:39.588 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 05 01 00 
13:42:39.588 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:39.588 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=ApplicationCommandHandler, expected=SendData, cancelled=false
13:42:40.343 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:42:40.724 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:42:42.176 [DEBUG] [z.internal.ZWaveNetworkMonitor:341  ] - NODE 2: Sending periodic PING.
13:42:42.177 [DEBUG] [c.ZWaveNoOperationCommandClass:72   ] - NODE 2: Creating new message for command No Operation
13:42:42.177 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 2: Creating empty message of class = SendData (0x13), type = Request (0x00)
13:42:42.177 [DEBUG] [b.z.i.protocol.ZWaveController:898  ] - Callback ID = 73
13:42:42.177 [DEBUG] [b.z.i.protocol.ZWaveController:580  ] - Enqueueing message. Queue length = 1
13:42:42.177 [DEBUG] [WaveController$ZWaveSendThread:1171 ] - Took message from queue for sending. Queue length = 0
13:42:42.177 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 08 00 13 02 01 00 25 49 8B 
13:42:42.177 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - NODE 2: Sending REQUEST Message = 01 08 00 13 02 01 00 25 49 8B 
13:42:42.184 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 04 01 13 01 E8 
13:42:42.184 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:42.184 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:42.184 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 04 01 13 01 E8 
13:42:42.184 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 04 01 13 01 E8 
13:42:42.184 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 
13:42:42.184 [DEBUG] [b.z.i.p.s.SendDataMessageClass:38   ] - NODE 2: Sent Data successfully placed on stack.
13:42:42.221 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 07 00 13 49 00 00 04 A6 
13:42:42.221 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:42.221 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:42.221 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 09 00 13 49 00 00 04 00 00 A8 
13:42:42.221 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 09 00 13 49 00 00 04 00 00 A8 
13:42:42.221 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = SendData (0x13), type = Request (0x00), payload = 49 00 00 04 
13:42:42.221 [DEBUG] [b.z.i.p.s.SendDataMessageClass:74   ] - NODE 2: SendData Request. CallBack ID = 73, Status = Transmission complete and ACK received(0)
13:42:42.222 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:63   ] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 02 01 00 
13:42:42.222 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:64   ] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 49 00 00 04 
13:42:42.222 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:65   ] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false
13:42:42.222 [DEBUG] [.z.i.p.s.ZWaveCommandProcessor:68   ] -          transaction complete!
13:42:42.222 [DEBUG] [b.z.i.protocol.ZWaveController:595  ] - Notifying event listeners: ZWaveTransactionCompletedEvent
13:42:42.222 [DEBUG] [.z.internal.ZWaveActiveBinding:433  ] - ZwaveIncomingEvent
13:42:42.222 [DEBUG] [WaveController$ZWaveSendThread:1287 ] - NODE 2: Response processed after 45ms/1260ms.
SW1 on
13:42:48.936 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:48.937 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:48.937 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:48.937 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:48.937 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:48.937 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:48.937 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:42:48.937 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:48.937 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:48.938 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:42:48.938 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:48.938 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:48.938 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:42:48.938 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:48.939 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:42:48.939 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.
SW1 off
13:42:58.536 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:58.536 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:42:58.536 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:42:58.537 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:58.537 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 01 10 01 20 25 8F 
13:42:58.537 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 01 10 01 20 25 
13:42:58.537 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:42:58.537 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:58.537 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:42:58.537 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:42:58.537 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:42:58.538 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:42:58.538 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:42:58.538 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:42:58.538 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.

Here is the section of the log for SW2 toggling twice.

SW2 on
13:43:03.786 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:03.786 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:43:03.786 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:43:03.786 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:03.786 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:03.786 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:43:03.786 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:43:03.786 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:43:03.786 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:43:03.786 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:43:03.786 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:03.787 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:43:03.787 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:03.787 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:43:03.787 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:03.787 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:43:03.787 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.
13:43:05.725 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:43:06.151 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
SW2 off
13:43:24.115 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:24.115 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:43:24.115 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:43:24.115 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:24.115 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:24.115 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:43:24.115 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:43:24.115 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:43:24.115 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:43:24.115 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:43:24.115 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:24.116 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:43:24.116 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:24.116 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:43:24.116 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:24.116 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:43:24.116 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.
13:43:31.151 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:43:31.544 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
SW2 on
13:43:44.596 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:44.596 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:43:44.596 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:43:44.596 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:44.596 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:43:44.596 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:43:44.596 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:43:44.596 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:43:44.596 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:43:44.596 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:44.597 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:43:44.597 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:43:44.597 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:43:44.597 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:43:44.597 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:43:44.597 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.
13:43:56.545 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:43:56.969 [DEBUG] [.myopenhab.internal.MyOHClient:150  ] - Transport.EVENT_REQUEST_HEADERS
13:44:04.628 [DEBUG] [eController$ZWaveReceiveThread:1441 ] - Receive Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
SW2 off
13:44:04.628 [DEBUG] [eController$ZWaveReceiveThread:1365 ] - Receive queue ADD: Length=1
13:44:04.628 [DEBUG] [b.z.i.protocol.ZWaveController:1123 ] - Receive queue TAKE: Length=0
13:44:04.629 [DEBUG] [o.b.z.i.protocol.SerialMessage:233  ] - Assembled message buffer = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:44:04.629 [DEBUG] [b.z.i.protocol.ZWaveController:1124 ] - Process Message = 01 0D 00 04 04 05 07 60 0A 02 10 01 20 25 8C 
13:44:04.629 [DEBUG] [b.z.i.protocol.ZWaveController:190  ] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 04 05 07 60 0A 02 10 01 20 25 
13:44:04.629 [DEBUG] [ApplicationCommandMessageClass:38   ] - NODE 5: Application Command Request (ALIVE:DONE)
13:44:04.629 [DEBUG] [ApplicationCommandMessageClass:56   ] - NODE 5: Incoming command class MULTI_INSTANCE
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:145  ] - NODE 5: Received Multi-instance/Multi-channel Request
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:301  ] - NODE 5: Process Multi-channel capability Report
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:307  ] - NODE 5: Endpoints are the same device class = true
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 1
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:44:04.629 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class BASIC.
13:44:04.629 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:44:04.629 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 1: Adding command class SWITCH_BINARY.
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:373  ] - NODE 5: Endpoint Id = 2
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:374  ] - NODE 5: Endpoints is dynamic = false
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:375  ] - NODE 5: Basic = Routing Slave 0x04
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:376  ] - NODE 5: Generic = Binary Switch 0x10
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:377  ] - NODE 5: Specific = Binary Power Switch 0x01
13:44:04.630 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class BASIC
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class BASIC.
13:44:04.630 [DEBUG] [.o.b.z.i.p.c.ZWaveCommandClass:224  ] - NODE 5: Creating new instance of command class SWITCH_BINARY
13:44:04.630 [DEBUG] [ZWaveMultiInstanceCommandClass:408  ] - NODE 5: Endpoint 2: Adding command class SWITCH_BINARY.
13:44:04.630 [DEBUG] [ApplicationCommandMessageClass:85   ] - Transaction not completed: node address inconsistent.
13:44:12.179 [DEBUG] [z.internal.ZWaveNetworkMonitor:341  ] - NODE 3: Sending periodic PING.
13:44:12.179 [DEBUG] [c.ZWaveNoOperationCommandClass:72   ] - NODE 3: Creating new message for command No Operation
13:44:12.179 [DEBUG] [o.b.z.i.protocol.SerialMessage:109  ] - NODE 3: Creating empty message of class = SendData (0x13), type = Request (0x00)


I haven’t raised an issue before. Can you give me the link to post it to? Thanks.

Thanks. It’s really a strange thing this :confused:

You can raise an issue here. I’m not sure it will be implemented in OH1 (probably not though) - maybe we can find something to fix this in OH2, but it probably requires some refactoring :frowning:

I don’t know if you solved your issue but here is my work around to get my dual relay switches status updated after it has been physically toggled. I placed all my dual relay switches in one switches.items file. I will use your setup as an example.

Switch Front_Outdoor_Light “Front Outdoor Lights” (main) {zwave=“5:1:command=switch_binary”}
Switch Foyer_Light “Foyer Light” (main) {zwave=“5:2:command=switch_binary”}

I also added:
Switch zw_switch_nodeFive “Node 5 binding of 0” { zwave=“5:command=SWITCH_BINARY” }

When you physically toggle the switch you will get a status update on zw_switch_nodeFive, but you dont know if it was the front door or the foyer. So now a made rule to append a space to switches.items file. Every time switches.items file is updated openhab polls the switches in that file and your switch status has been updated.

If you have found a fix or better way. Please let me know.