Z-Wave: Config challenges

[Pirx (DaHome Solutions)]

I’m using OH for years, but I’m a ZWAVE beginner and do have some config problems.

I’m using a Z-Wave USB Stick called “UZB” from z-wave.me
The corresponding Thing is ONLINE. The Serial Port is set to /dev/ttyACM0
Strange is that although zwave_neighbours=2 the Network Map is empty !

1. Why is that so?

2. Next question: what means the DEBUG message: “No bridgeUID found in getConfigDescription thing:zwave:serial_zstick:512” ?

3. There is a bad Z-Wave node entry which somehow cannot be deleted. The status is “REMOVING…” (now for two days). So maybe I should clean up the entire ZWAVE stuff and start from scratch. What is the best way to do it?

• Platform information:
  • OS: ubilinux 4.0 based on Debian Stretch
  • Java Runtime Environment: 11
  • openHAB version: 3.3

[apella12 (Bob Eckhoff)]

@Pirx

Strange is that although zwave_neighbours=2 the Network Map is empty !

Could be that the home ID is not on the Controller UI page. This can be added with the Developer API tool, but the network map is really of limited diagnostic value.

Home ID can be found from the node XMLs in the userdate/zwave folder.

@Pirx

• Next question: what means the DEBUG message: “No bridgeUID found in getConfigDescription thing:zwave:serial_zstick:512” ?

Should not be a concern. The zstick is a bridge, so it doesn’t have a bridgeUID.

@Pirx

There is a bad Z-Wave node entry which somehow cannot be deleted. The status is “REMOVING…” (now for two days). So maybe I should clean up the entire ZWAVE stuff and start from scratch. What is the best way to do it?

You could try force remove by removing again. If this node shows up again with a scan there is a PC controller app from Silabs that can remove zombie nodes.
Z-Wave Zombies.pdf (571.9 KB). Or your factory reset idea, if you only have one node.

Good luck

[Pirx (DaHome Solutions)]

I was able to remove the zombie by reinstalling the binding

What makes me wonder is that the properties of my serial controller look different:

Why is that so?

I have turned now the Zwave Binding into DEBUG mode. You can here see the log after turning the node 1 OFF and ON. Maybe you detect any anomalies !?

Thank YOU for helping me!

2022-08-22 15:37:24.325 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Handler disposed. Unregistering listener.
2022-08-22 15:37:24.349 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Handler disposed. Unregistering listener.
2022-08-22 15:37:24.385 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing receive thread
2022-08-22 15:37:24.592 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Stopped ZWave thread: Receive
2022-08-22 15:37:24.593 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Receive thread dispose
2022-08-22 15:37:24.594 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing serial connection
2022-08-22 15:37:24.706 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial connection disposed
2022-08-22 15:37:24.707 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Stopped ZWave serial handler
2022-08-22 15:37:24.711 [DEBUG] [ve.internal.protocol.ZWaveController] - Shutting down ZWave controller
2022-08-22 15:37:24.712 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Shutting down transaction manager
2022-08-22 15:37:24.713 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Exiting ZWave Receive Thread
2022-08-22 15:37:24.716 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction manager shutdown
2022-08-22 15:37:24.718 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node Init transaction completed with response TIMEOUT_WAITING_FOR_RESPONSE
2022-08-22 15:37:24.719 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Deactivate zwave:serial_zstick:512
2022-08-22 15:37:24.719 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer - advancing to DONE
2022-08-22 15:37:24.721 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 1: Serializing to file /var/lib/openhab/zwave/network_ea012def__node_1.xml
2022-08-22 15:37:24.730 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave controller shutdown
2022-08-22 15:37:27.711 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Creating ZWave discovery service for zwave:serial_zstick:512 with scan time of 60
2022-08-22 15:37:27.712 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Active zwave:serial_zstick:512
2022-08-22 15:37:27.713 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
2022-08-22 15:37:27.788 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller.
2022-08-22 15:37:27.789 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller zwave:serial_zstick:512.
2022-08-22 15:37:27.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:512:node2.
2022-08-22 15:37:27.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:512:node3.
2022-08-22 15:37:27.803 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: MANUFACTURER not set
2022-08-22 15:37:32.805 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Connecting to serial port '/dev/ttyACM0'
2022-08-22 15:37:32.813 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Starting receive thread
2022-08-22 15:37:32.814 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial port is initialized
2022-08-22 15:37:32.814 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Starting ZWave thread: Receive
2022-08-22 15:37:32.815 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initialising ZWave controller
2022-08-22 15:37:32.816 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2022-08-22 15:37:32.817 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:32.817 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2022-08-22 15:37:32.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:32.818 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-08-22 15:37:32.820 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-08-22 15:37:32.821 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Scheduling network mesh heal for 11 hours time.
2022-08-22 15:37:35.819 [DEBUG] [.ZWaveController$InitializeDelayTask] - Initialising network
2022-08-22 15:37:35.822 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 54 to queue - size 1
2022-08-22 15:37:35.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.825 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 15 E9 
2022-08-22 15:37:35.826 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9 
2022-08-22 15:37:35.830 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 54: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.831 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 55 to queue - size 1
2022-08-22 15:37:35.831 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 56 to queue - size 2
2022-08-22 15:37:35.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.833 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.833 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.833 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 57 to queue - size 3
2022-08-22 15:37:35.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 54: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.834 [DEBUG] [rialmessage.GetSucNodeIdMessageClass] - Get SUC NodeID
2022-08-22 15:37:35.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 58 to queue - size 4
2022-08-22 15:37:35.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.838 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 01 15 5A 2D 57 61 76 65 20 34 2E 36 31 00 01 95 
2022-08-22 15:37:35.840 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=GetVersion[21], type=Response[1], dest=255, callback=0, payload=5A 2D 57 61 76 65 20 34 2E 36 31 00 01 
2022-08-22 15:37:35.840 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=GetVersion[21], type=Response[1], dest=255, callback=0, payload=5A 2D 57 61 76 65 20 34 2E 36 31 00 01 
2022-08-22 15:37:35.841 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 54: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.842 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:35.843 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 54: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.843 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=GetVersion[21], type=Response[1], dest=255, callback=0, payload=5A 2D 57 61 76 65 20 34 2E 36 31 00 01 
2022-08-22 15:37:35.845 [DEBUG] [serialmessage.GetVersionMessageClass] - Got MessageGetVersion response. Version=Z-Wave 4.61, Library Type=1
2022-08-22 15:37:35.845 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 54: Transaction COMPLETED
2022-08-22 15:37:35.846 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 16ms
2022-08-22 15:37:35.847 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 54: Transaction completed
2022-08-22 15:37:35.847 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:54 DONE
2022-08-22 15:37:35.848 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.851 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 20 DC 
2022-08-22 15:37:35.851 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 20 DC 
2022-08-22 15:37:35.852 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.853 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 55: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.853 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.853 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.854 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 01 20 EA 01 2D EF 01 FE 
2022-08-22 15:37:35.855 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.855 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=MemoryGetId[32], type=Response[1], dest=255, callback=0, payload=EA 01 2D EF 01 
2022-08-22 15:37:35.855 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 55: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.856 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.857 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=MemoryGetId[32], type=Response[1], dest=255, callback=0, payload=EA 01 2D EF 01 
2022-08-22 15:37:35.857 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 55: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:35.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 55: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.859 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=MemoryGetId[32], type=Response[1], dest=255, callback=0, payload=EA 01 2D EF 01 
2022-08-22 15:37:35.859 [DEBUG] [erialmessage.MemoryGetIdMessageClass] - Got MessageMemoryGetId response. Home id = 0xea012def, Controller Node id = 1
2022-08-22 15:37:35.860 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 55: Transaction COMPLETED
2022-08-22 15:37:35.860 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 7ms
2022-08-22 15:37:35.861 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 55: Transaction completed
2022-08-22 15:37:35.861 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:55 DONE
2022-08-22 15:37:35.862 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.865 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.865 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 07 FB 
2022-08-22 15:37:35.866 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 07 FB 
2022-08-22 15:37:35.866 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.866 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 56: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.867 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.870 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 2B 01 07 05 19 01 15 04 00 00 01 FE 85 7F 88 CF 3F C0 47 FB DF FD E0 67 00 80 80 00 80 86 00 00 00 E8 73 00 80 0F 00 00 60 5A 00 52 
2022-08-22 15:37:35.872 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SerialApiGetCapabilities[7], type=Response[1], dest=255, callback=0, payload=05 19 01 15 04 00 00 01 FE 85 7F 88 CF 3F C0 47 FB DF FD E0 67 00 80 80 00 80 86 00 00 00 E8 73 00 80 0F 00 00 60 5A 00 
2022-08-22 15:37:35.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.873 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 56: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.873 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.874 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SerialApiGetCapabilities[7], type=Response[1], dest=255, callback=0, payload=05 19 01 15 04 00 00 01 FE 85 7F 88 CF 3F C0 47 FB DF FD E0 67 00 80 80 00 80 86 00 00 00 E8 73 00 80 0F 00 00 60 5A 00 
2022-08-22 15:37:35.875 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 56: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.875 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:35.876 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 56: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.877 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SerialApiGetCapabilities[7], type=Response[1], dest=255, callback=0, payload=05 19 01 15 04 00 00 01 FE 85 7F 88 CF 3F C0 47 FB DF FD E0 67 00 80 80 00 80 86 00 00 00 E8 73 00 80 0F 00 00 60 5A 00 
2022-08-22 15:37:35.877 [DEBUG] [SerialApiGetCapabilitiesMessageClass] - API Version    = 5.25
2022-08-22 15:37:35.878 [DEBUG] [SerialApiGetCapabilitiesMessageClass] - Manufacture ID = 0x115
2022-08-22 15:37:35.878 [DEBUG] [SerialApiGetCapabilitiesMessageClass] - Device Type    = 0x400
2022-08-22 15:37:35.879 [DEBUG] [SerialApiGetCapabilitiesMessageClass] - Device ID      = 0x1
2022-08-22 15:37:35.880 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 56: Transaction COMPLETED
2022-08-22 15:37:35.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 59 to queue - size 3
2022-08-22 15:37:35.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 16ms
2022-08-22 15:37:35.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 56: Transaction completed
2022-08-22 15:37:35.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:56 DONE
2022-08-22 15:37:35.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.887 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 06 96 0F 65 
2022-08-22 15:37:35.888 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 06 96 0F 65 
2022-08-22 15:37:35.888 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.889 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.890 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.891 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 01 06 96 0F 64 
2022-08-22 15:37:35.891 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 1<>127 : Message: class=SerialApiSetTimeouts[6], type=Response[1], dest=255, callback=0, payload=96 0F 
2022-08-22 15:37:35.889 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 57: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.893 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (1): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 57: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.899 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SerialApiSetTimeouts[6], type=Response[1], dest=255, callback=0, payload=96 0F 
2022-08-22 15:37:35.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 57: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:35.902 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 57: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.902 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SerialApiSetTimeouts[6], type=Response[1], dest=255, callback=0, payload=96 0F 
2022-08-22 15:37:35.903 [DEBUG] [age.SerialApiSetTimeoutsMessageClass] - Got SerialApiSetTimeouts response. ACK=150, BYTE=15
2022-08-22 15:37:35.903 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 57: Transaction COMPLETED
2022-08-22 15:37:35.904 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 15ms
2022-08-22 15:37:35.905 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 57: Transaction completed
2022-08-22 15:37:35.905 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:57 DONE
2022-08-22 15:37:35.906 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.912 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.914 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 56 AA 
2022-08-22 15:37:35.914 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 56 AA 
2022-08-22 15:37:35.915 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.916 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.916 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 58: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.917 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.917 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 56 01 AD 
2022-08-22 15:37:35.917 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.918 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=GetSucNodeId[86], type=Response[1], dest=255, callback=0, payload=01 
2022-08-22 15:37:35.919 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 58: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=GetSucNodeId[86], type=Response[1], dest=255, callback=0, payload=01 
2022-08-22 15:37:35.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 58: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.922 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:35.923 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 58: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.923 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=GetSucNodeId[86], type=Response[1], dest=255, callback=0, payload=01 
2022-08-22 15:37:35.924 [DEBUG] [rialmessage.GetSucNodeIdMessageClass] - Got SUC NodeID response.
2022-08-22 15:37:35.924 [DEBUG] [rialmessage.GetSucNodeIdMessageClass] - NODE 1: Node is SUC.
2022-08-22 15:37:35.925 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 58: Transaction COMPLETED
2022-08-22 15:37:35.925 [DEBUG] [etControllerCapabilitiesMessageClass] - Creating GET_CONTROLLER_CAPABILITIES message
2022-08-22 15:37:35.926 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 60 to queue - size 2
2022-08-22 15:37:35.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:35.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 11ms
2022-08-22 15:37:35.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 58: Transaction completed
2022-08-22 15:37:35.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:58 DONE
2022-08-22 15:37:35.929 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.931 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:35.932 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 02 FE 
2022-08-22 15:37:35.932 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 02 FE 
2022-08-22 15:37:35.933 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:35.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 59: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.934 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:35.938 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.938 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:35.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 59: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:35.940 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:35.940 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:35.940 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2022-08-22 15:37:36.030 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 25 01 02 06 08 1D 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 05 00 CE 
2022-08-22 15:37:36.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SerialApiGetInitData[2], type=Response[1], dest=255, callback=0, payload=06 08 1D 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 05 00 
2022-08-22 15:37:36.033 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SerialApiGetInitData[2], type=Response[1], dest=255, callback=0, payload=06 08 1D 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 05 00 
2022-08-22 15:37:36.035 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 59: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.036 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:36.038 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 59: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.039 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SerialApiGetInitData[2], type=Response[1], dest=255, callback=0, payload=06 08 1D 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 05 00 
2022-08-22 15:37:36.040 [DEBUG] [age.SerialApiGetInitDataMessageClass] - Got MessageSerialApiGetInitData response.
2022-08-22 15:37:36.041 [DEBUG] [age.SerialApiGetInitDataMessageClass] - NODE 1: Node found
2022-08-22 15:37:36.042 [DEBUG] [age.SerialApiGetInitDataMessageClass] - ZWave Controller using Controller API
2022-08-22 15:37:36.042 [DEBUG] [age.SerialApiGetInitDataMessageClass] - ZWave Controller is Primary Controller
2022-08-22 15:37:36.043 [DEBUG] [age.SerialApiGetInitDataMessageClass] - ------------Number of Nodes Found Registered to ZWave Controller------------
2022-08-22 15:37:36.043 [DEBUG] [age.SerialApiGetInitDataMessageClass] - # Nodes = 1
2022-08-22 15:37:36.044 [DEBUG] [age.SerialApiGetInitDataMessageClass] - ----------------------------------------------------------------------------
2022-08-22 15:37:36.044 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 59: Transaction COMPLETED
2022-08-22 15:37:36.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 111ms
2022-08-22 15:37:36.045 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 1: Init node thread start
2022-08-22 15:37:36.046 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 59: Transaction completed
2022-08-22 15:37:36.046 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:59 DONE
2022-08-22 15:37:36.047 [DEBUG] [ve.internal.protocol.ZWaveController] - Starting waiting for init threads
2022-08-22 15:37:36.048 [DEBUG] [ve.internal.protocol.ZWaveController] - Waiting for init thread Node_1_init
2022-08-22 15:37:36.050 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:36.051 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:36.052 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 05 F9 
2022-08-22 15:37:36.053 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 05 F9 
2022-08-22 15:37:36.054 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:36.054 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 60: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.054 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:36.055 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:36.056 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:36.056 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 05 3C C3 
2022-08-22 15:37:36.057 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 60: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.058 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=GetControllerCapabilities[5], type=Response[1], dest=255, callback=0, payload=3C 
2022-08-22 15:37:36.058 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:36.059 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=GetControllerCapabilities[5], type=Response[1], dest=255, callback=0, payload=3C 
2022-08-22 15:37:36.060 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 60: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.061 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:36.062 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 60: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.063 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=GetControllerCapabilities[5], type=Response[1], dest=255, callback=0, payload=3C 
2022-08-22 15:37:36.064 [DEBUG] [etControllerCapabilitiesMessageClass] - Controller is secondary = false
2022-08-22 15:37:36.064 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 1: Serializing from file /var/lib/openhab/zwave/network_ea012def__node_1.xml
2022-08-22 15:37:36.073 [DEBUG] [etControllerCapabilitiesMessageClass] - Controller is on other network = false
2022-08-22 15:37:36.073 [DEBUG] [etControllerCapabilitiesMessageClass] - Node ID Server is present = false
2022-08-22 15:37:36.074 [DEBUG] [etControllerCapabilitiesMessageClass] - Controller is real primary = true
2022-08-22 15:37:36.075 [DEBUG] [etControllerCapabilitiesMessageClass] - Controller is SUC = true
2022-08-22 15:37:36.076 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 60: Transaction COMPLETED
2022-08-22 15:37:36.077 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 22ms
2022-08-22 15:37:36.077 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 60: Transaction completed
2022-08-22 15:37:36.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:60 DONE
2022-08-22 15:37:36.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:36.080 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:36.086 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 1: Restore from config: Ok.
2022-08-22 15:37:36.087 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Command class COMMAND_CLASS_NO_OPERATION, endpoint 0 created
2022-08-22 15:37:36.088 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Command class COMMAND_CLASS_BASIC, endpoint 0 created
2022-08-22 15:37:36.089 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Starting initialisation from EMPTYNODE
2022-08-22 15:37:36.090 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 1: Init node thread finished
2022-08-22 15:37:36.090 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer - advancing to IDENTIFY_NODE
2022-08-22 15:37:36.090 [DEBUG] [ve.internal.protocol.ZWaveController] - Init thread Node_1_init complete
2022-08-22 15:37:36.091 [DEBUG] [ve.internal.protocol.ZWaveController] - All init threads complete
2022-08-22 15:37:36.092 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer: Initialisation starting
2022-08-22 15:37:36.092 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Controller: Incoming Network State Event true
2022-08-22 15:37:36.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@74059c57
2022-08-22 15:37:36.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Controller status changed to ONLINE.
2022-08-22 15:37:36.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Controller status changed to ONLINE.
2022-08-22 15:37:36.094 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Controller is ONLINE. Starting device initialisation.
2022-08-22 15:37:36.094 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Controller is ONLINE. Starting device initialisation.
2022-08-22 15:37:36.100 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-08-22 15:37:36.101 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Initialising Thing Node...
2022-08-22 15:37:36.102 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling initialised at 86400 seconds - start in 11404800 milliseconds.
2022-08-22 15:37:36.103 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2022-08-22 15:37:36.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 61 to queue - size 1
2022-08-22 15:37:36.104 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising Thing Node...
2022-08-22 15:37:36.104 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:36.104 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Device initialisation complete.
2022-08-22 15:37:36.105 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 41 01 BB 
2022-08-22 15:37:36.105 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising cmd channel zwave:device:512:node2:switch_binary for OnOffType
2022-08-22 15:37:36.106 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 41 01 BB 
2022-08-22 15:37:36.106 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary for OnOffType
2022-08-22 15:37:36.107 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2022-08-22 15:37:36.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 61: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.108 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2022-08-22 15:37:36.108 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary for OnOffType
2022-08-22 15:37:36.108 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:36.109 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2022-08-22 15:37:36.110 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 01 41 D3 16 01 02 02 01 73 
2022-08-22 15:37:36.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 61: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=IdentifyNode[65], type=Response[1], dest=255, callback=0, payload=D3 16 01 02 02 01 
2022-08-22 15:37:36.110 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising cmd channel zwave:device:512:node2:switch_binary1 for OnOffType
2022-08-22 15:37:36.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2022-08-22 15:37:36.111 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary1 for OnOffType
2022-08-22 15:37:36.111 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=IdentifyNode[65], type=Response[1], dest=255, callback=0, payload=D3 16 01 02 02 01 
2022-08-22 15:37:36.112 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 61: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2022-08-22 15:37:36.113 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary1 for OnOffType
2022-08-22 15:37:36.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 61: [WAIT_RESPONSE] priority=Controller, requiresResponse=true, callback: 0
2022-08-22 15:37:36.114 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=IdentifyNode[65], type=Response[1], dest=255, callback=0, payload=D3 16 01 02 02 01 
2022-08-22 15:37:36.115 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising cmd channel zwave:device:512:node2:switch_binary2 for OnOffType
2022-08-22 15:37:36.115 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: ProtocolInfo
2022-08-22 15:37:36.116 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Listening = true
2022-08-22 15:37:36.116 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary2 for OnOffType
2022-08-22 15:37:36.116 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Routing   = true
2022-08-22 15:37:36.117 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Beaming   = true
2022-08-22 15:37:36.117 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Version   = 4
2022-08-22 15:37:36.117 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Initialising state channel zwave:device:512:node2:switch_binary2 for OnOffType
2022-08-22 15:37:36.118 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: FLIRS     = false
2022-08-22 15:37:36.118 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Security  = false
2022-08-22 15:37:36.119 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Max Baud  = 40000
2022-08-22 15:37:36.119 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling initialised at 86400 seconds - start in 44582400 milliseconds.
2022-08-22 15:37:36.119 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Basic    = BASIC_TYPE_STATIC_CONTROLLER
2022-08-22 15:37:36.120 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Generic  = GENERIC_TYPE_STATIC_CONTROLLER
2022-08-22 15:37:36.120 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Device initialisation complete.
2022-08-22 15:37:36.121 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 1: Specific = SPECIFIC_TYPE_PC_CONTROLLER
2022-08-22 15:37:36.121 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Creating new instance of command class COMMAND_CLASS_NO_OPERATION
2022-08-22 15:37:36.122 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Command class COMMAND_CLASS_NO_OPERATION, endpoint 0 created
2022-08-22 15:37:36.122 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Version = 1, version set. Enabling extra functionality.
2022-08-22 15:37:36.123 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 1: Adding command class COMMAND_CLASS_NO_OPERATION to the list of supported command classes.
2022-08-22 15:37:36.124 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Creating new instance of command class COMMAND_CLASS_BASIC
2022-08-22 15:37:36.124 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 1: Command class COMMAND_CLASS_BASIC, endpoint 0 created
2022-08-22 15:37:36.125 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 1: Adding command class COMMAND_CLASS_BASIC to the list of supported command classes.
2022-08-22 15:37:36.126 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 61: Transaction COMPLETED
2022-08-22 15:37:36.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 19ms
2022-08-22 15:37:36.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 61: Transaction completed
2022-08-22 15:37:36.127 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:61 DONE
2022-08-22 15:37:36.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2022-08-22 15:37:36.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 61: Transaction event listener: DONE: DONE -> UNINTIALIZED
2022-08-22 15:37:36.129 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@7efdf727
2022-08-22 15:37:36.130 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node Init transaction completed with response COMPLETE
2022-08-22 15:37:36.130 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer: FAILED_CHECK - Controller - terminating initialisation
2022-08-22 15:37:36.131 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer - advancing to DONE
2022-08-22 15:37:36.132 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 1: Serializing to file /var/lib/openhab/zwave/network_ea012def__node_1.xml
2022-08-22 15:37:36.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2022-08-22 15:37:36.242 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - No bridgeUID found in getConfigDescription thing:zwave:serial_zstick:512

[apella12 (Bob Eckhoff)]

Looks ok to me. I’m assuming you are worried about the network Map?

Try adding the Home ID (ea012def) with the API explorer.

First do a GET things UID, then copy the output.
Go to PUT things UID, paste output, but add “zwave_homeid”: “ea012def”,