2023-09-19 22:07:46.501 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'QubinoFlushRGBWWohnzimmerVorhang_ColorTemperature' received command 20
2023-09-19 22:07:46.504 [INFO ] [penhab.event.ItemStatePredictedEvent] - Item 'QubinoFlushRGBWWohnzimmerVorhang_ColorTemperature' predicted to become 20
2023-09-19 22:07:46.506 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'QubinoFlushRGBWWohnzimmerVorhang_ColorTemperature' changed from 0 to 20

2023-09-19 22:07:46.514 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Command received zwave:device:835b63ed:node33:color_temperature --> 20 [PercentType]
2023-09-19 22:07:46.515 [DEBUG] [ternal.converter.ZWaveColorConverter] - NODE 33: Converted command '20' to {WARM_WHITE=51, COLD_WHITE=204} for channel = zwave:device:835b63ed:node33:color_temperature, endpoint = 0.
2023-09-19 22:07:46.516 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.517 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:46.518 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 0
2023-09-19 22:07:46.518 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 4
2023-09-19 22:07:46.520 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 2
2023-09-19 22:07:46.520 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 3
2023-09-19 22:07:46.521 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.522 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:46.523 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.524 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:46.526 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.527 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:46.528 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.529 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:46.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:46.531 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41383 to queue - size 6
2023-09-19 22:07:46.532 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:46.533 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0F 00 13 21 08 33 05 02 00 33 01 CC FF 25 8D 57 
2023-09-19 22:07:46.534 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0F 00 13 21 08 33 05 02 00 33 01 CC FF 25 8D 57 
2023-09-19 22:07:46.536 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:46.537 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:46.538 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.537 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41383: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 141
2023-09-19 22:07:46.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:46.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:46.540 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:46.542 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41384 to queue - size 6
2023-09-19 22:07:46.544 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.544 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:46.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41385 to queue - size 7
2023-09-19 22:07:46.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.550 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:46.550 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:46.553 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41386 to queue - size 8
2023-09-19 22:07:46.554 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.554 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.555 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.555 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41383: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 141
2023-09-19 22:07:46.557 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.558 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41383: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 141
2023-09-19 22:07:46.559 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.560 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:46.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41383: Advanced to WAIT_REQUEST
2023-09-19 22:07:46.563 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41383: Transaction not completed
2023-09-19 22:07:46.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.565 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:46.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41387 to queue - size 9
2023-09-19 22:07:46.568 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.570 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling initialised at 86400 seconds - start in 1500 milliseconds.
2023-09-19 22:07:46.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.681 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8D 00 00 0E 68 
2023-09-19 22:07:46.684 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0E 
2023-09-19 22:07:46.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0E 
2023-09-19 22:07:46.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41383: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 141
2023-09-19 22:07:46.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41383: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 141
2023-09-19 22:07:46.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41383: (Callback 141)
2023-09-19 22:07:46.688 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:46.688 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41383: callback 141
2023-09-19 22:07:46.689 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0E 
2023-09-19 22:07:46.689 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 141, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:46.690 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:46.691 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 41383: Transaction COMPLETED
2023-09-19 22:07:46.691 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Response processed after 154ms
2023-09-19 22:07:46.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41383: Transaction completed
2023-09-19 22:07:46.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41383 DONE
2023-09-19 22:07:46.694 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:46.697 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.697 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:46.698 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 00 25 8E 5F 
2023-09-19 22:07:46.699 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 00 25 8E 5F 
2023-09-19 22:07:46.702 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:46.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.704 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:46.705 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41384: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41384: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.707 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:46.707 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.707 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.711 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:46.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.718 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41384: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.722 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41384: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.722 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.723 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:46.723 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41384: Advanced to WAIT_REQUEST
2023-09-19 22:07:46.724 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41384: Transaction not completed
2023-09-19 22:07:46.724 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.765 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8E 00 00 06 63 
2023-09-19 22:07:46.768 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 06 
2023-09-19 22:07:46.771 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 06 
2023-09-19 22:07:46.772 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41384: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.773 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.774 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41384: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 142
2023-09-19 22:07:46.775 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41384: (Callback 142)
2023-09-19 22:07:46.776 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:46.777 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41384: callback 142
2023-09-19 22:07:46.779 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 06 
2023-09-19 22:07:46.780 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 142, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:46.781 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:46.782 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41384: Advanced to WAIT_DATA
2023-09-19 22:07:46.785 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41384: Transaction not completed
2023-09-19 22:07:46.785 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.846 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 00 05 E6 
2023-09-19 22:07:46.849 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 00 05 
2023-09-19 22:07:46.851 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 00 05 
2023-09-19 22:07:46.851 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:46.852 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:46.853 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:46.854 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:46.856 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:46.857 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:46.858 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report WARM_WHITE 5
2023-09-19 22:07:46.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:46.859 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@498d788b.
2023-09-19 22:07:46.860 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@498d788b.
2023-09-19 22:07:46.861 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41384 DONE
2023-09-19 22:07:46.862 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:46.863 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:46.864 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:46.864 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.865 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:46.865 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 04 25 8F 5A 
2023-09-19 22:07:46.866 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 04 25 8F 5A 
2023-09-19 22:07:46.869 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:46.870 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.870 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:46.871 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41385: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.872 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:46.872 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41385: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.872 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:46.873 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.873 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.878 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:46.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41385: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.885 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41385: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.886 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:46.886 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:46.887 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41385: Advanced to WAIT_REQUEST
2023-09-19 22:07:46.889 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41385: Transaction not completed
2023-09-19 22:07:46.890 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.891 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:46.975 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8F 00 00 0A 6E 
2023-09-19 22:07:46.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 0A 
2023-09-19 22:07:46.979 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 0A 
2023-09-19 22:07:46.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41385: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:46.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41385: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 143
2023-09-19 22:07:46.983 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41385: (Callback 143)
2023-09-19 22:07:46.984 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:46.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41385: callback 143
2023-09-19 22:07:46.985 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 0A 
2023-09-19 22:07:46.987 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 143, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:46.989 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:46.991 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41385: Advanced to WAIT_DATA
2023-09-19 22:07:46.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41385: Transaction not completed
2023-09-19 22:07:46.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:46.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.056 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 04 00 E7 
2023-09-19 22:07:47.060 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 04 00 
2023-09-19 22:07:47.061 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 04 00 
2023-09-19 22:07:47.062 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:47.063 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:47.064 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:47.065 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:47.066 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:47.067 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:47.067 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report BLUE 0
2023-09-19 22:07:47.068 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:47.069 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6b2bea7a.
2023-09-19 22:07:47.069 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6b2bea7a.
2023-09-19 22:07:47.070 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41385 DONE
2023-09-19 22:07:47.072 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:47.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:47.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:47.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:47.075 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 02 25 90 43 
2023-09-19 22:07:47.075 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 02 25 90 43 
2023-09-19 22:07:47.077 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:47.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:47.079 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:47.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41386: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.080 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:47.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41386: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:47.082 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.082 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.086 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:47.088 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41386: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.091 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:47.091 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41386: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.092 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.092 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:47.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41386: Advanced to WAIT_REQUEST
2023-09-19 22:07:47.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41386: Transaction not completed
2023-09-19 22:07:47.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.186 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 90 00 00 0B 70 
2023-09-19 22:07:47.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=144, payload=90 00 00 0B 
2023-09-19 22:07:47.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=144, payload=90 00 00 0B 
2023-09-19 22:07:47.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41386: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:47.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41386: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 144
2023-09-19 22:07:47.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41386: (Callback 144)
2023-09-19 22:07:47.196 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:47.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41386: callback 144
2023-09-19 22:07:47.198 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=144, payload=90 00 00 0B 
2023-09-19 22:07:47.198 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 144, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:47.199 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:47.200 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41386: Advanced to WAIT_DATA
2023-09-19 22:07:47.201 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41386: Transaction not completed
2023-09-19 22:07:47.202 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.202 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.264 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 02 00 E1 
2023-09-19 22:07:47.267 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 02 00 
2023-09-19 22:07:47.268 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 02 00 
2023-09-19 22:07:47.269 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:47.270 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:47.270 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:47.271 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:47.272 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:47.273 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:47.274 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report RED 0
2023-09-19 22:07:47.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:47.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@28471aea.
2023-09-19 22:07:47.276 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@28471aea.
2023-09-19 22:07:47.277 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41386 DONE
2023-09-19 22:07:47.278 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:47.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:47.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:47.282 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.283 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:47.283 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 03 25 91 43 
2023-09-19 22:07:47.284 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 03 25 91 43 
2023-09-19 22:07:47.287 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:47.288 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:47.288 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41387: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.288 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:47.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:47.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41387: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.290 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:47.290 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.290 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.295 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:47.298 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41387: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:47.301 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41387: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.301 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:47.302 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:47.302 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41387: Advanced to WAIT_REQUEST
2023-09-19 22:07:47.302 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41387: Transaction not completed
2023-09-19 22:07:47.302 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.303 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.396 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 91 00 00 0B 71 
2023-09-19 22:07:47.399 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=145, payload=91 00 00 0B 
2023-09-19 22:07:47.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=145, payload=91 00 00 0B 
2023-09-19 22:07:47.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41387: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:47.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41387: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 145
2023-09-19 22:07:47.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41387: (Callback 145)
2023-09-19 22:07:47.405 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:47.405 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41387: callback 145
2023-09-19 22:07:47.406 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=145, payload=91 00 00 0B 
2023-09-19 22:07:47.408 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 145, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:47.409 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:47.410 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41387: Advanced to WAIT_DATA
2023-09-19 22:07:47.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41387: Transaction not completed
2023-09-19 22:07:47.412 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:47.476 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 03 00 E0 
2023-09-19 22:07:47.479 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 03 00 
2023-09-19 22:07:47.480 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 03 00 
2023-09-19 22:07:47.481 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:47.482 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:47.483 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:47.484 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:47.485 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:47.486 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:47.487 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report GREEN 0
2023-09-19 22:07:47.488 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report finished {WARM_WHITE=5, BLUE=0, RED=0, GREEN=0}
2023-09-19 22:07:47.489 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveColorValueEvent
2023-09-19 22:07:47.490 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_COLOR, value=0
2023-09-19 22:07:47.490 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_color to 0,0,0 [HSBType]
2023-09-19 22:07:47.492 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_temperature to 100 [PercentType]
==> /var/log/openhab/events.log <==
2023-09-19 22:07:47.497 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'QubinoFlushRGBWWohnzimmerVorhang_ColorTemperature' changed from 20 to 100
2023-09-19 22:07:47.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:47.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7957bd59.
2023-09-19 22:07:47.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7957bd59.
2023-09-19 22:07:47.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41387 DONE
2023-09-19 22:07:47.500 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:47.500 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:47.504 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:47.506 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:47.507 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.070 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling...
2023-09-19 22:07:48.070 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:switch_dimmer
2023-09-19 22:07:48.071 [DEBUG] [erter.ZWaveMultiLevelSwitchConverter] - NODE 33: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2023-09-19 22:07:48.071 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 33: Creating new message for command SWITCH_MULTILEVEL_GET
2023-09-19 22:07:48.072 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.073 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2023-09-19 22:07:48.073 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling skipped for zwave:device:835b63ed:node33:switch_dimmer on COMMAND_CLASS_BASIC
2023-09-19 22:07:48.074 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:color_color
2023-09-19 22:07:48.075 [DEBUG] [ternal.converter.ZWaveColorConverter] - NODE 33: Generating poll message for COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:48.075 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 0
2023-09-19 22:07:48.077 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 4
2023-09-19 22:07:48.077 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 2
2023-09-19 22:07:48.078 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 3
2023-09-19 22:07:48.079 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.080 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.081 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.082 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.083 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.083 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.084 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.085 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.085 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:color_color
2023-09-19 22:07:48.086 [DEBUG] [erter.ZWaveMultiLevelSwitchConverter] - NODE 33: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2023-09-19 22:07:48.087 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 33: Creating new message for command SWITCH_MULTILEVEL_GET
2023-09-19 22:07:48.088 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.088 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2023-09-19 22:07:48.089 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:color_temperature
2023-09-19 22:07:48.090 [DEBUG] [ternal.converter.ZWaveColorConverter] - NODE 33: Generating poll message for COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:48.090 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE Node 33: Manufacturer=0159, Type=0001, Id=0054: Color refresh is already in progress
2023-09-19 22:07:48.091 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 0
2023-09-19 22:07:48.094 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 4
2023-09-19 22:07:48.095 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 2
2023-09-19 22:07:48.096 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Creating new message for application command SWITCH_COLOR_GET 3
2023-09-19 22:07:48.097 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.098 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.099 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.100 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.101 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.102 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.103 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.104 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_SWITCH_COLOR is NOT required to be secured
2023-09-19 22:07:48.105 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:config_decimal_param5
2023-09-19 22:07:48.106 [DEBUG] [onverter.ZWaveConfigurationConverter] - NODE 33: Generating poll message for COMMAND_CLASS_CONFIGURATION, endpoint 0
2023-09-19 22:07:48.107 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 33: Creating new message for application command CONFIGURATIONCMD_GET
2023-09-19 22:07:48.108 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.109 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_CONFIGURATION is NOT required to be secured
2023-09-19 22:07:48.110 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Polling zwave:device:835b63ed:node33:config_decimal_param6
2023-09-19 22:07:48.111 [DEBUG] [onverter.ZWaveConfigurationConverter] - NODE 33: Generating poll message for COMMAND_CLASS_CONFIGURATION, endpoint 0
2023-09-19 22:07:48.112 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 33: Creating new message for application command CONFIGURATIONCMD_GET
2023-09-19 22:07:48.113 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.116 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Command Class COMMAND_CLASS_CONFIGURATION is NOT required to be secured
2023-09-19 22:07:48.117 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.118 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41388 to queue - size 6
2023-09-19 22:07:48.118 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.119 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 21 02 26 02 25 92 55 
2023-09-19 22:07:48.120 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 09 00 13 21 02 26 02 25 92 55 
2023-09-19 22:07:48.123 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:48.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.127 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:48.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:48.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.130 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:48.131 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:48.133 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41388: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 146
2023-09-19 22:07:48.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.135 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.137 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.138 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41388: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 146
2023-09-19 22:07:48.138 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.139 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41388: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 146
2023-09-19 22:07:48.140 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.141 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:48.142 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41388: Advanced to WAIT_REQUEST
2023-09-19 22:07:48.142 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41388: Transaction not completed
2023-09-19 22:07:48.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41389 to queue - size 6
2023-09-19 22:07:48.146 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.147 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.146 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.149 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41390 to queue - size 7
2023-09-19 22:07:48.149 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.151 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.152 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.153 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41391 to queue - size 8
2023-09-19 22:07:48.154 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.155 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.155 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41392 to queue - size 9
2023-09-19 22:07:48.158 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.159 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.160 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41393 to queue - size 10
2023-09-19 22:07:48.160 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.162 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.163 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Transaction already in queue - removed original
2023-09-19 22:07:48.164 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41394 to queue - size 10
2023-09-19 22:07:48.165 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.167 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Transaction already in queue - removed original
2023-09-19 22:07:48.168 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41395 to queue - size 10
2023-09-19 22:07:48.169 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Transaction already in queue - removed original
2023-09-19 22:07:48.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41396 to queue - size 10
2023-09-19 22:07:48.173 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.174 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Transaction already in queue - removed original
2023-09-19 22:07:48.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41397 to queue - size 10
2023-09-19 22:07:48.176 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41398 to queue - size 11
2023-09-19 22:07:48.180 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2023-09-19 22:07:48.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 41399 to queue - size 12
2023-09-19 22:07:48.183 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.184 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 92 00 00 06 7F 
2023-09-19 22:07:48.190 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=146, payload=92 00 00 06 
2023-09-19 22:07:48.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=146, payload=92 00 00 06 
2023-09-19 22:07:48.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41388: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 146
2023-09-19 22:07:48.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41388: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 146
2023-09-19 22:07:48.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41388: (Callback 146)
2023-09-19 22:07:48.194 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:48.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41388: callback 146
2023-09-19 22:07:48.195 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=146, payload=92 00 00 06 
2023-09-19 22:07:48.196 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 146, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:48.196 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41388: Advanced to WAIT_DATA
2023-09-19 22:07:48.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41388: Transaction not completed
2023-09-19 22:07:48.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.200 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.265 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 21 03 26 03 13 E6 
2023-09-19 22:07:48.268 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 03 26 03 13 
2023-09-19 22:07:48.269 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 03 26 03 13 
2023-09-19 22:07:48.270 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:48.270 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:48.271 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.271 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2023-09-19 22:07:48.272 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.272 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_MULTILEVEL V2 SWITCH_MULTILEVEL_REPORT
2023-09-19 22:07:48.273 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 33: Switch Multi Level report, value = 19
2023-09-19 22:07:48.274 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-09-19 22:07:48.275 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_MULTILEVEL, value=19
2023-09-19 22:07:48.275 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:switch_dimmer to 19 [PercentType]
==> /var/log/openhab/events.log <==
2023-09-19 22:07:48.278 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'QubinoFlushRGBWWohnzimmerVorhang_Dimmer' changed from 0 to 19
==> /var/log/openhab/openhab.log <==
2023-09-19 22:07:48.279 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_color to 19 [PercentType]
==> /var/log/openhab/events.log <==
2023-09-19 22:07:48.282 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'QubinoFlushRGBWWohnzimmerVorhang_ColorControl' changed from 0,0,0 to 0,0,19
==> /var/log/openhab/openhab.log <==
2023-09-19 22:07:48.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:48.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5bbcdbd8.
2023-09-19 22:07:48.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5bbcdbd8.
2023-09-19 22:07:48.287 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41388 DONE
2023-09-19 22:07:48.288 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:48.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:48.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:48.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.290 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.290 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 21 02 26 02 25 93 54 
2023-09-19 22:07:48.290 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 09 00 13 21 02 26 02 25 93 54 
2023-09-19 22:07:48.294 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:48.295 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:48.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41393: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.297 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.298 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41393: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.298 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:48.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.301 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:48.304 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41393: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41393: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.309 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.310 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:48.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41393: Advanced to WAIT_REQUEST
2023-09-19 22:07:48.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41393: Transaction not completed
2023-09-19 22:07:48.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.396 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 93 00 00 0A 72 
2023-09-19 22:07:48.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=147, payload=93 00 00 0A 
2023-09-19 22:07:48.400 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=147, payload=93 00 00 0A 
2023-09-19 22:07:48.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41393: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41393: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 147
2023-09-19 22:07:48.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41393: (Callback 147)
2023-09-19 22:07:48.404 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:48.406 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41393: callback 147
2023-09-19 22:07:48.407 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=147, payload=93 00 00 0A 
2023-09-19 22:07:48.409 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 147, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:48.411 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.412 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41393: Advanced to WAIT_DATA
2023-09-19 22:07:48.414 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41393: Transaction not completed
2023-09-19 22:07:48.415 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.475 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 21 03 26 03 13 E6 
2023-09-19 22:07:48.478 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 03 26 03 13 
2023-09-19 22:07:48.480 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 03 26 03 13 
2023-09-19 22:07:48.481 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:48.482 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:48.483 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.485 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2023-09-19 22:07:48.486 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.489 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_MULTILEVEL V2 SWITCH_MULTILEVEL_REPORT
2023-09-19 22:07:48.491 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 33: Switch Multi Level report, value = 19
2023-09-19 22:07:48.492 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-09-19 22:07:48.493 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_MULTILEVEL, value=19
2023-09-19 22:07:48.494 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:switch_dimmer to 19 [PercentType]
2023-09-19 22:07:48.495 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_color to 19 [PercentType]
2023-09-19 22:07:48.495 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:48.496 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6f7082ef.
2023-09-19 22:07:48.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6f7082ef.
2023-09-19 22:07:48.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41393 DONE
2023-09-19 22:07:48.499 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:48.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:48.500 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:48.500 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.503 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.504 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 00 25 94 45 
2023-09-19 22:07:48.505 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 00 25 94 45 
2023-09-19 22:07:48.508 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:48.509 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.510 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:48.510 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41394: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.511 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.512 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41394: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.513 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:48.513 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.514 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.516 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:48.520 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.521 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.522 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41394: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.522 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.523 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41394: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.523 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.524 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:48.524 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41394: Advanced to WAIT_REQUEST
2023-09-19 22:07:48.525 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41394: Transaction not completed
2023-09-19 22:07:48.525 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.525 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.607 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 94 00 00 0A 75 
2023-09-19 22:07:48.610 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=148, payload=94 00 00 0A 
2023-09-19 22:07:48.621 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=148, payload=94 00 00 0A 
2023-09-19 22:07:48.624 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41394: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.624 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.625 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41394: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 148
2023-09-19 22:07:48.626 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41394: (Callback 148)
2023-09-19 22:07:48.626 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:48.631 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41394: callback 148
2023-09-19 22:07:48.633 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=148, payload=94 00 00 0A 
2023-09-19 22:07:48.633 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 148, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:48.634 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.634 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41394: Advanced to WAIT_DATA
2023-09-19 22:07:48.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41394: Transaction not completed
2023-09-19 22:07:48.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.686 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 00 33 D0 
2023-09-19 22:07:48.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 00 33 
2023-09-19 22:07:48.690 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 00 33 
2023-09-19 22:07:48.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:48.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:48.694 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.695 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:48.695 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.697 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:48.698 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report WARM_WHITE 51
2023-09-19 22:07:48.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:48.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7ff055a1.
2023-09-19 22:07:48.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7ff055a1.
2023-09-19 22:07:48.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41394 DONE
2023-09-19 22:07:48.703 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:48.707 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:48.709 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:48.710 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.713 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 04 25 95 40 
2023-09-19 22:07:48.714 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 04 25 95 40 
2023-09-19 22:07:48.716 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:48.716 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:48.717 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41395: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.718 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.718 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41395: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:48.720 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.720 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.725 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:48.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.731 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41395: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.731 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41395: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.733 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.733 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:48.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41395: Advanced to WAIT_REQUEST
2023-09-19 22:07:48.735 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41395: Transaction not completed
2023-09-19 22:07:48.735 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.736 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.815 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 95 00 00 0A 74 
2023-09-19 22:07:48.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=149, payload=95 00 00 0A 
2023-09-19 22:07:48.819 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=149, payload=95 00 00 0A 
2023-09-19 22:07:48.821 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41395: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.822 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41395: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 149
2023-09-19 22:07:48.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41395: (Callback 149)
2023-09-19 22:07:48.825 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:48.826 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41395: callback 149
2023-09-19 22:07:48.827 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=149, payload=95 00 00 0A 
2023-09-19 22:07:48.828 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 149, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:48.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.831 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41395: Advanced to WAIT_DATA
2023-09-19 22:07:48.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41395: Transaction not completed
2023-09-19 22:07:48.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.897 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 04 00 E7 
2023-09-19 22:07:48.904 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 04 00 
2023-09-19 22:07:48.907 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 04 00 
2023-09-19 22:07:48.908 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:48.909 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:48.910 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:48.912 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:48.914 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:48.915 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:48.919 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report BLUE 0
2023-09-19 22:07:48.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:48.923 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3b899273.
2023-09-19 22:07:48.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3b899273.
2023-09-19 22:07:48.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41395 DONE
2023-09-19 22:07:48.930 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:48.931 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:48.932 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:48.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.935 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:48.936 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 02 25 96 45 
2023-09-19 22:07:48.942 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 02 25 96 45 
2023-09-19 22:07:48.946 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:48.946 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:48.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41396: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:48.955 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:48.957 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41396: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:48.957 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:48.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:48.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:48.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.965 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.967 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41396: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:48.969 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:48.971 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41396: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:48.971 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:48.972 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:48.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41396: Advanced to WAIT_REQUEST
2023-09-19 22:07:48.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41396: Transaction not completed
2023-09-19 22:07:48.974 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:48.974 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.026 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 96 00 00 08 75 
2023-09-19 22:07:49.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=150, payload=96 00 00 08 
2023-09-19 22:07:49.032 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=150, payload=96 00 00 08 
2023-09-19 22:07:49.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41396: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:49.035 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.036 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41396: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 150
2023-09-19 22:07:49.037 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41396: (Callback 150)
2023-09-19 22:07:49.038 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:49.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41396: callback 150
2023-09-19 22:07:49.041 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=150, payload=96 00 00 08 
2023-09-19 22:07:49.041 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 150, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:49.042 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41396: Advanced to WAIT_DATA
2023-09-19 22:07:49.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41396: Transaction not completed
2023-09-19 22:07:49.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.106 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 02 00 E1 
2023-09-19 22:07:49.109 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 02 00 
2023-09-19 22:07:49.112 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 02 00 
2023-09-19 22:07:49.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:49.117 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:49.119 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.120 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:49.121 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:49.121 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:49.122 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report RED 0
2023-09-19 22:07:49.122 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:49.123 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6d6fcc1.
2023-09-19 22:07:49.123 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6d6fcc1.
2023-09-19 22:07:49.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41396 DONE
2023-09-19 22:07:49.125 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:49.125 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:49.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:49.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:49.130 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 33 03 03 25 97 45 
2023-09-19 22:07:49.130 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 33 03 03 25 97 45 
2023-09-19 22:07:49.133 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:49.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.135 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:49.135 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41397: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.136 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.137 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41397: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.138 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:49.138 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.139 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.142 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:49.145 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.146 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.146 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41397: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.147 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.150 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41397: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.151 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.151 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:49.152 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41397: Advanced to WAIT_REQUEST
2023-09-19 22:07:49.153 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41397: Transaction not completed
2023-09-19 22:07:49.153 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.154 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.236 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 97 00 00 0A 76 
2023-09-19 22:07:49.239 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=151, payload=97 00 00 0A 
2023-09-19 22:07:49.241 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=151, payload=97 00 00 0A 
2023-09-19 22:07:49.243 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41397: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.246 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41397: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 151
2023-09-19 22:07:49.247 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41397: (Callback 151)
2023-09-19 22:07:49.248 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:49.250 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41397: callback 151
2023-09-19 22:07:49.250 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=151, payload=97 00 00 0A 
2023-09-19 22:07:49.251 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 151, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:49.252 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41397: Advanced to WAIT_DATA
2023-09-19 22:07:49.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41397: Transaction not completed
2023-09-19 22:07:49.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.316 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 21 04 33 04 03 00 E0 
2023-09-19 22:07:49.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 03 00 
2023-09-19 22:07:49.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 04 33 04 03 00 
2023-09-19 22:07:49.321 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:49.322 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:49.323 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_SWITCH_COLOR, endpoint 0
2023-09-19 22:07:49.325 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:49.325 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_SWITCH_COLOR V2 SWITCH_COLOR_REPORT
2023-09-19 22:07:49.326 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report GREEN 0
2023-09-19 22:07:49.327 [DEBUG] [.commandclass.ZWaveColorCommandClass] - NODE 33: Color report finished {WARM_WHITE=51, BLUE=0, RED=0, GREEN=0}
2023-09-19 22:07:49.327 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveColorValueEvent
2023-09-19 22:07:49.328 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_COLOR, value=0
2023-09-19 22:07:49.329 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_color to 0,0,0 [HSBType]
2023-09-19 22:07:49.330 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:color_temperature to 100 [PercentType]
2023-09-19 22:07:49.333 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:49.336 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6d5a710e.
2023-09-19 22:07:49.337 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6d5a710e.
2023-09-19 22:07:49.337 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41397 DONE
2023-09-19 22:07:49.338 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:49.339 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:49.339 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:49.339 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.342 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:49.342 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 70 05 05 25 98 09 
2023-09-19 22:07:49.343 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 70 05 05 25 98 09 
2023-09-19 22:07:49.346 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:49.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.348 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:49.348 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41398: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.349 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.350 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41398: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.351 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:49.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.355 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:49.358 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.359 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.360 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41398: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.361 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.363 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41398: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.365 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:49.365 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41398: Advanced to WAIT_REQUEST
2023-09-19 22:07:49.366 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41398: Transaction not completed
2023-09-19 22:07:49.367 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.367 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.446 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 98 00 00 0A 79 
2023-09-19 22:07:49.449 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=152, payload=98 00 00 0A 
2023-09-19 22:07:49.450 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=152, payload=98 00 00 0A 
2023-09-19 22:07:49.451 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41398: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.451 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41398: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 152
2023-09-19 22:07:49.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41398: (Callback 152)
2023-09-19 22:07:49.454 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:49.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41398: callback 152
2023-09-19 22:07:49.455 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=152, payload=98 00 00 0A 
2023-09-19 22:07:49.455 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 152, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:49.456 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41398: Advanced to WAIT_DATA
2023-09-19 22:07:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41398: Transaction not completed
2023-09-19 22:07:49.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.527 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 21 05 70 06 05 01 03 A5 
2023-09-19 22:07:49.531 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 05 70 06 05 01 03 
2023-09-19 22:07:49.534 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 05 70 06 05 01 03 
2023-09-19 22:07:49.535 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:49.535 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:49.536 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.537 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_CONFIGURATION, endpoint 0
2023-09-19 22:07:49.537 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:49.537 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_CONFIGURATION V1 CONFIGURATIONCMD_REPORT
2023-09-19 22:07:49.538 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 33: Node configuration report, parameter = 5, value = 3, size = 1
2023-09-19 22:07:49.539 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveConfigurationParameterEvent
2023-09-19 22:07:49.539 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_CONFIGURATION, value=org.openhab.binding.zwave.internal.protocol.ZWaveConfigurationParameter@2b1e294a
2023-09-19 22:07:49.540 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Update CONFIGURATION 5/1 to 3
2023-09-19 22:07:49.541 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Configuration pending removed for config_5_1
2023-09-19 22:07:49.542 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:config_decimal_param5 to 3 [DecimalType]
2023-09-19 22:07:49.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:49.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@10fa7c59.
2023-09-19 22:07:49.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@10fa7c59.
2023-09-19 22:07:49.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41398 DONE
2023-09-19 22:07:49.547 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:49.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:49.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:49.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-09-19 22:07:49.549 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 21 03 70 05 06 25 99 0B 
2023-09-19 22:07:49.550 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 33: Sending REQUEST Message = 01 0A 00 13 21 03 70 05 06 25 99 0B 
2023-09-19 22:07:49.552 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2023-09-19 22:07:49.553 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 41399: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.553 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2023-09-19 22:07:49.554 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.555 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2023-09-19 22:07:49.555 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41399: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.556 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2023-09-19 22:07:49.556 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.557 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.561 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2023-09-19 22:07:49.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.565 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41399: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.567 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41399: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.567 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2023-09-19 22:07:49.568 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: sentData successfully placed on stack.
2023-09-19 22:07:49.569 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41399: Advanced to WAIT_REQUEST
2023-09-19 22:07:49.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41399: Transaction not completed
2023-09-19 22:07:49.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.571 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.656 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 99 00 00 0A 78 
2023-09-19 22:07:49.659 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=153, payload=99 00 00 0A 
2023-09-19 22:07:49.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=153, payload=99 00 00 0A 
2023-09-19 22:07:49.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 41399: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2023-09-19 22:07:49.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 41399: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 153
2023-09-19 22:07:49.665 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 41399: (Callback 153)
2023-09-19 22:07:49.666 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2023-09-19 22:07:49.666 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 41399: callback 153
2023-09-19 22:07:49.667 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=153, payload=99 00 00 0A 
2023-09-19 22:07:49.668 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 33: SendData Request. CallBack ID = 153, Status = Transmission complete and ACK received(0)
2023-09-19 22:07:49.669 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.670 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 41399: Advanced to WAIT_DATA
2023-09-19 22:07:49.671 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: TID 41399: Transaction not completed
2023-09-19 22:07:49.671 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2023-09-19 22:07:49.737 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 21 06 70 06 06 02 00 01 A3 
2023-09-19 22:07:49.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 06 70 06 06 02 00 01 
2023-09-19 22:07:49.742 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=33, callback=0, payload=00 21 06 70 06 06 02 00 01 
2023-09-19 22:07:49.743 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-09-19 22:07:49.744 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Application Command Request (ALIVE:DONE)
2023-09-19 22:07:49.745 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: resetResendCount initComplete=true isDead=false
2023-09-19 22:07:49.745 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: Incoming command class COMMAND_CLASS_CONFIGURATION, endpoint 0
2023-09-19 22:07:49.746 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 33: SECURITY not supported
2023-09-19 22:07:49.748 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 33: Received COMMAND_CLASS_CONFIGURATION V1 CONFIGURATIONCMD_REPORT
2023-09-19 22:07:49.749 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 33: Node configuration report, parameter = 6, value = 1, size = 2
2023-09-19 22:07:49.750 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveConfigurationParameterEvent
2023-09-19 22:07:49.752 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_CONFIGURATION, value=org.openhab.binding.zwave.internal.protocol.ZWaveConfigurationParameter@7bc1f430
2023-09-19 22:07:49.753 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Update CONFIGURATION 6/2 to 1
2023-09-19 22:07:49.755 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Configuration pending removed for config_6_2
2023-09-19 22:07:49.756 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Updating channel state zwave:device:835b63ed:node33:config_decimal_param6 to 1 [DecimalType]
2023-09-19 22:07:49.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Commands processed 1.
2023-09-19 22:07:49.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@67177e3f.
2023-09-19 22:07:49.760 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@67177e3f.
2023-09-19 22:07:49.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: notifyTransactionResponse TID:41399 DONE
2023-09-19 22:07:49.763 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 33: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2023-09-19 22:07:49.764 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2023-09-19 22:07:49.766 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-09-19 22:07:49.769 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-09-19 22:07:49.771 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.