VRCS4 Troubles

Tags: #<Tag:0x00007f3879b990c0>
  • Platform information:
    • Hardware: Macbook Air
    • OS: Mac OS X 10.14.4
    • Java Runtime Environment: 1.8.0_121
    • openHAB version: 4.2.1

I’m attempting to configure a VRCS4 4-scene controller. I believe that I need to set association groups for it to include the controller. However, every time I set it, it reverts back to having no group set.

My capture debug log was too large, here is a link: https://pastebin.com/NN57mEEE

If you are talking about zwave, yes, you should set the association groups to your controller.
Please use HABmin to to do that.
There is a display bug in HABmin, although the associations are set correctly, they don’t show up.
You need to catch the events from the scene_number channel in a rule to use that device.
https://www.cd-jackson.com/index.php/zwave/zwave-device-database/zwave-device-list/devicesummary/197

There is nothing in it from zwave …:


log:set DEBUG org.openhab.binding.zwave is the correct Karaf command to set the zwave binding to debug.

Thanks for your help!

I had been using PaperUI to set the groups, so I tried with Habmin

Now the association groups are listed as pending and I get the following log: (thanks for providing the right log setting)

10:49:39.037 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_7_1 to 99 (BigDecimal)

10:49:39.037 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_8_2 to 5 (BigDecimal)

10:49:39.037 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_9_1 to 1 (BigDecimal)

10:49:39.038 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_12_2 to 3 (BigDecimal)

10:49:39.038 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_3_1 to 0 (BigDecimal)

10:49:39.038 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored config_4_1 to 0 (BigDecimal)

10:49:39.038 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update set config_5_1 to 0 (BigDecimal)

10:49:39.038 [DEBUG] [dclass.ZWaveConfigurationCommandClass] - NODE 2: Creating new message for application command CONFIGURATION_SET

10:49:39.038 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported

10:49:39.039 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_CONFIGURATION is NOT required to be secured

10:49:39.039 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue

10:49:39.040 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: Added 922 to queue - size 2

10:49:39.040 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:49:39.041 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 13 02 05 70 04 05 01 00 25 8C 3E 

10:49:39.041 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0C 00 13 02 05 70 04 05 01 00 25 8C 3E 

10:49:39.041 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:49:39.041 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 922: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 140

10:49:39.042 [DEBUG] [dclass.ZWaveConfigurationCommandClass] - NODE 2: Creating new message for application command CONFIGURATIONCMD_GET

10:49:39.042 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported

10:49:39.042 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_CONFIGURATION is NOT required to be secured

10:49:39.042 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue

10:49:39.043 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: Added 923 to queue - size 2

10:49:39.043 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:49:39.043 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Configuration update ignored node_id to 2 (BigDecimal)

10:49:39.044 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'zwave:device:050e0827:node2' has been updated.

10:49:39.046 [INFO ] [smarthome.event.ConfigStatusInfoEvent] - ConfigStatusInfo [configStatusMessages=[ConfigStatusMessage [parameterName=config_5_1, type=PENDING, messageKey=null, arguments=null, message=null, statusCode=null]]]

10:49:41.045 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 2: TID 922: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:49:41.046 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:49:41.046 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 922: Transaction ABORTED

10:49:41.046 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:49:41.046 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:49:41.047 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:49:41.047 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:49:53.047 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 2: TID 922: Timeout at state ABORTED. 3 retries remaining.

10:49:53.047 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 922: Transaction is current transaction, so clearing!!!!!

10:49:53.047 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 922: Transaction CANCELLED

10:49:53.047 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:49:53.048 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:922 CANCELLED

10:49:53.048 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:49:53.048 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 02 03 70 05 05 25 8D 3F 

10:49:53.049 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0A 00 13 02 03 70 05 05 25 8D 3F 

10:49:53.049 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:49:53.049 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 923: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 141

10:49:55.055 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 2: TID 923: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:49:55.055 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:49:55.055 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 923: Transaction ABORTED

10:49:55.055 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:49:55.056 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:49:55.056 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:49:55.056 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:07.059 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 2: TID 923: Timeout at state ABORTED. 3 retries remaining.

10:50:07.060 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 923: Transaction is current transaction, so clearing!!!!!

10:50:07.061 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 923: Transaction CANCELLED

10:50:07.061 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:50:07.062 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:923 CANCELLED

10:50:07.063 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:50:31.841 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Configuration update received

10:50:31.842 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Configuration update set group_4 to [controller] (ArrayList)

10:50:31.843 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=4, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.843 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=4, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.843 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=4, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.844 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_REMOVE group=4, node=1

10:50:31.844 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.845 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.845 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.845 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 924 to queue - size 2

10:50:31.846 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:50:31.846 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 04 04 01 25 8E C5 

10:50:31.846 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 04 04 01 25 8E C5 

10:50:31.846 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:50:31.847 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 924: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 142

10:50:31.847 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=4, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.847 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_SET, group=4, node=1

10:50:31.848 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.848 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.849 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.849 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 925 to queue - size 2

10:50:31.850 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.850 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_GET group 4

10:50:31.851 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.852 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.853 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.854 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 926 to queue - size 3

10:50:31.855 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.855 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Configuration update set group_1 to [controller] (ArrayList)

10:50:31.856 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=1, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.856 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=1, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.857 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=1, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.858 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_REMOVE group=1, node=1

10:50:31.858 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.859 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.860 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.860 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 927 to queue - size 4

10:50:31.861 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.861 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=1, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.862 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_SET, group=1, node=1

10:50:31.862 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.862 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.862 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.863 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 928 to queue - size 5

10:50:31.863 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.863 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_GET group 1

10:50:31.864 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.864 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.864 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.865 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 929 to queue - size 6

10:50:31.865 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.865 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Configuration update set group_3 to [controller] (ArrayList)

10:50:31.866 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=3, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.866 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=3, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.867 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=3, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.867 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_REMOVE group=3, node=1

10:50:31.868 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.868 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.868 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.869 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 930 to queue - size 7

10:50:31.869 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.869 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=3, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.870 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_SET, group=3, node=1

10:50:31.870 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.870 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.871 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.871 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 931 to queue - size 8

10:50:31.872 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.872 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_GET group 3

10:50:31.873 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.873 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.873 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.874 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 932 to queue - size 9

10:50:31.874 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.874 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Configuration update set group_2 to [controller] (ArrayList)

10:50:31.875 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=2, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.875 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Current Members ZWaveAssociationGroup [index=2, name=null, profile1=null, profile2=null, associations=[node_1]]

10:50:31.879 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=2, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.880 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_REMOVE group=2, node=1

10:50:31.881 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.881 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.881 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.882 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 933 to queue - size 10

10:50:31.882 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.882 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: New Members ZWaveAssociationGroup [index=2, name=null, profile1=null, profile2=null, associations=[node_1_1]]

10:50:31.883 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_SET, group=2, node=1

10:50:31.884 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.884 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.885 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.885 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 934 to queue - size 11

10:50:31.886 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.886 [DEBUG] [andclass.ZWaveAssociationCommandClass] - NODE 9: Creating new message for application command ASSOCIATIONCMD_GET group 2

10:50:31.887 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported

10:50:31.887 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_ASSOCIATION is NOT required to be secured

10:50:31.887 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue

10:50:31.888 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: Added 935 to queue - size 12

10:50:31.888 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:31.890 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'zwave:device:050e0827:node9' has been updated.

10:50:31.892 [INFO ] [smarthome.event.ConfigStatusInfoEvent] - ConfigStatusInfo [configStatusMessages=[ConfigStatusMessage [parameterName=group_4, type=PENDING, messageKey=null, arguments=null, message=null, statusCode=null], ConfigStatusMessage [parameterName=group_1, type=PENDING, messageKey=null, arguments=null, message=null, statusCode=null], ConfigStatusMessage [parameterName=group_3, type=PENDING, messageKey=null, arguments=null, message=null, statusCode=null], ConfigStatusMessage [parameterName=group_2, type=PENDING, messageKey=null, arguments=null, message=null, statusCode=null]]]

10:50:33.851 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 924: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:50:33.852 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:50:33.852 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 924: Transaction ABORTED

10:50:33.853 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:50:33.853 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:50:33.853 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:50:33.854 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:45.855 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 924: Timeout at state ABORTED. 3 retries remaining.

10:50:45.855 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 924: Transaction is current transaction, so clearing!!!!!

10:50:45.856 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 924: Transaction CANCELLED

10:50:45.856 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:50:45.856 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:924 CANCELLED

10:50:45.857 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:50:45.857 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 01 04 01 25 8F C1 

10:50:45.858 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 01 04 01 25 8F C1 

10:50:45.858 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:50:45.858 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 925: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 143

10:50:47.864 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 925: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:50:47.865 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:50:47.865 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 925: Transaction ABORTED

10:50:47.865 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:50:47.866 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:50:47.866 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:50:47.866 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:50:59.869 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 925: Timeout at state ABORTED. 3 retries remaining.

10:50:59.870 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 925: Transaction is current transaction, so clearing!!!!!

10:50:59.871 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 925: Transaction CANCELLED

10:50:59.871 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:50:59.872 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:925 CANCELLED

10:50:59.874 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:50:59.875 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 85 02 04 25 90 DA 

10:50:59.876 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 85 02 04 25 90 DA 

10:50:59.877 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:50:59.877 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 926: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 144

10:51:01.881 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 926: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:51:01.882 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:51:01.883 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 926: Transaction ABORTED

10:51:01.884 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:51:01.885 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:51:01.885 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:01.886 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:51:13.890 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 926: Timeout at state ABORTED. 3 retries remaining.

10:51:13.890 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 926: Transaction is current transaction, so clearing!!!!!

10:51:13.890 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 926: Transaction CANCELLED

10:51:13.891 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:51:13.891 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:926 CANCELLED

10:51:13.892 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:51:13.892 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 04 01 01 25 91 DF 

10:51:13.893 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 04 01 01 25 91 DF 

10:51:13.893 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:13.893 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 927: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 145

10:51:15.898 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 927: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:51:15.898 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:51:15.898 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 927: Transaction ABORTED

10:51:15.899 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:51:15.899 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:51:15.900 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:15.900 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:51:27.905 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 927: Timeout at state ABORTED. 3 retries remaining.

10:51:27.905 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 927: Transaction is current transaction, so clearing!!!!!

10:51:27.906 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 927: Transaction CANCELLED

10:51:27.906 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:51:27.907 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:927 CANCELLED

10:51:27.907 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:51:27.908 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 01 01 01 25 92 D9 

10:51:27.908 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 01 01 01 25 92 D9 

10:51:27.909 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:27.909 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 928: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 146

10:51:29.911 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 928: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:51:29.911 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:51:29.916 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 928: Transaction ABORTED

10:51:29.916 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:51:29.920 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:51:29.920 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:29.920 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:51:41.916 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 928: Timeout at state ABORTED. 3 retries remaining.

10:51:41.917 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 928: Transaction is current transaction, so clearing!!!!!

10:51:41.917 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 928: Transaction CANCELLED

10:51:41.917 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:51:41.918 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:928 CANCELLED

10:51:41.919 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:51:41.919 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 85 02 01 25 93 DC 

10:51:41.920 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 85 02 01 25 93 DC 

10:51:41.920 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:41.920 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 929: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 147

10:51:43.926 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 929: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:51:43.926 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:51:43.927 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 929: Transaction ABORTED

10:51:43.927 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:51:43.927 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:51:43.928 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:43.928 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:51:55.928 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 929: Timeout at state ABORTED. 3 retries remaining.

10:51:55.929 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 929: Transaction is current transaction, so clearing!!!!!

10:51:55.929 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 929: Transaction CANCELLED

10:51:55.930 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:51:55.932 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:929 CANCELLED

10:51:55.932 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:51:55.933 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 04 03 01 25 94 D8 

10:51:55.934 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 04 03 01 25 94 D8 

10:51:55.934 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:55.934 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 930: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 148

10:51:57.936 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 930: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:51:57.937 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:51:57.937 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 930: Transaction ABORTED

10:51:57.938 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:51:57.938 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:51:57.939 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:51:57.939 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:52:09.942 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 930: Timeout at state ABORTED. 3 retries remaining.

10:52:09.943 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 930: Transaction is current transaction, so clearing!!!!!

10:52:09.943 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 930: Transaction CANCELLED

10:52:09.944 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:52:09.944 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:930 CANCELLED

10:52:09.944 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:52:09.945 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 01 03 01 25 95 DC 

10:52:09.946 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 01 03 01 25 95 DC 

10:52:09.946 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:09.946 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 931: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 149

10:52:11.952 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 931: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:52:11.953 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:52:11.953 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 931: Transaction ABORTED

10:52:11.953 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:52:11.954 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:52:11.954 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:11.954 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:52:23.954 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 931: Timeout at state ABORTED. 3 retries remaining.

10:52:23.954 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 931: Transaction is current transaction, so clearing!!!!!

10:52:23.955 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 931: Transaction CANCELLED

10:52:23.957 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:52:23.957 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:931 CANCELLED

10:52:23.958 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:52:23.958 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 85 02 03 25 96 DB 

10:52:23.959 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 85 02 03 25 96 DB 

10:52:23.959 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:23.960 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 932: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 150

10:52:25.960 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 932: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:52:25.961 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:52:25.962 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 932: Transaction ABORTED

10:52:25.963 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:52:25.964 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:52:25.965 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:25.965 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:52:37.966 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 932: Timeout at state ABORTED. 3 retries remaining.

10:52:37.967 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 932: Transaction is current transaction, so clearing!!!!!

10:52:37.967 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 932: Transaction CANCELLED

10:52:37.967 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:52:37.967 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:932 CANCELLED

10:52:37.968 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:52:37.968 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 04 02 01 25 97 DA 

10:52:37.968 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 04 02 01 25 97 DA 

10:52:37.968 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:37.968 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 933: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 151

10:52:39.969 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 933: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:52:39.970 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:52:39.970 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 933: Transaction ABORTED

10:52:39.971 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:52:39.971 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:52:39.971 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:39.972 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:52:51.973 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 933: Timeout at state ABORTED. 3 retries remaining.

10:52:51.973 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 933: Transaction is current transaction, so clearing!!!!!

10:52:51.974 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 933: Transaction CANCELLED

10:52:51.974 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:52:51.974 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:933 CANCELLED

10:52:51.975 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:52:51.976 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 09 04 85 01 02 01 25 98 D0 

10:52:51.977 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0B 00 13 09 04 85 01 02 01 25 98 D0 

10:52:51.977 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:51.978 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 934: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 152

10:52:53.984 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 934: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:52:53.984 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:52:53.984 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 934: Transaction ABORTED

10:52:53.985 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:52:53.985 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:52:53.986 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:52:53.986 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:53:05.985 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 934: Timeout at state ABORTED. 3 retries remaining.

10:53:05.986 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 934: Transaction is current transaction, so clearing!!!!!

10:53:05.986 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 934: Transaction CANCELLED

10:53:05.987 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:53:05.987 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:934 CANCELLED

10:53:05.988 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

10:53:05.988 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 85 02 02 25 99 D5 

10:53:05.989 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 85 02 02 25 99 D5 

10:53:05.989 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:53:05.990 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 935: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 153

10:53:07.994 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 935: Timeout at state WAIT_RESPONSE. 3 retries remaining.

10:53:07.994 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - Aborting Transaction!

10:53:07.995 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 935: Transaction ABORTED

10:53:07.995 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA 

10:53:07.996 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA 

10:53:07.996 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

10:53:07.996 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

10:53:19.995 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 9: TID 935: Timeout at state ABORTED. 3 retries remaining.

10:53:19.996 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - TID 935: Transaction is current transaction, so clearing!!!!!

10:53:19.996 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 935: Transaction CANCELLED

10:53:19.996 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

10:53:19.997 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:935 CANCELLED

10:53:19.998 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

You need to wake the lock remote manually to transfer the settings to the device.

I pushed the various button on the remote (on the theory this would wake it) and the situation does not appear to have changed.

I excluded the device and re-included it.

Now I don’t get the pending message, but my scene number still isn’t coming through:

Log has references to an unsupported command type:

11:56:01.644 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:01.645 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:01.645 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:01.645 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:01.646 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:01.646 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:01.647 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:01.647 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:01.648 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:01.648 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:01.649 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:02.484 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:02.485 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:02.486 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:02.486 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:02.487 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:02.487 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:02.487 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:02.488 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:02.488 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:02.489 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:02.489 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:02.490 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:02.490 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:03.618 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:03.619 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:03.620 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:03.620 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:03.620 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:03.621 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:03.621 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:03.622 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:03.622 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:03.623 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:03.623 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:03.624 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:03.624 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:04.443 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:04.444 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:04.444 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:04.445 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:04.445 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:04.445 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:04.446 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:04.446 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:04.447 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:04.447 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:04.447 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:04.448 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:04.448 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:05.126 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:05.127 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.128 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.128 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:05.128 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:05.128 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:05.129 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.129 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:05.129 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:05.130 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:05.130 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:05.131 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:05.131 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:05.259 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:05.260 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.261 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.261 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:05.262 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:05.262 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:05.263 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.263 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:05.263 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:05.264 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:05.264 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:05.265 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:05.265 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:05.510 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:05.510 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.511 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.511 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:05.512 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:05.512 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:05.512 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.513 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:05.513 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:05.514 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:05.514 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:05.515 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:05.515 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:05.751 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:05.752 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.753 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.753 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:05.753 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:05.754 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:05.754 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:05.755 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:05.755 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:05.755 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:05.756 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:05.756 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:05.757 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:06.110 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:06.111 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.111 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.112 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:06.112 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:06.112 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:06.113 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.113 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:06.114 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:06.114 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:06.114 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:06.115 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:06.115 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:06.351 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:06.352 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.352 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.353 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:06.353 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:06.353 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:06.353 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:06.354 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:06.354 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:06.355 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:06.355 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:06.355 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:06.356 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:15.504 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling...

11:56:15.505 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling deferred until initialisation complete

11:56:22.168 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: ZWaveCommandClassTransactionPayload - send to node

11:56:22.169 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 10: SECURITY not supported

11:56:22.169 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 10: Command Class COMMAND_CLASS_VERSION is NOT required to be secured

11:56:22.170 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@512bc2f3

11:56:22.171 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: Adding to device queue

11:56:22.171 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: Added 1043 to queue - size 2

11:56:22.171 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:22.172 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0A 03 86 13 2C 25 DC AF 

11:56:22.172 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 10: Sending REQUEST Message = 01 0A 00 13 0A 03 86 13 2C 25 DC AF 

11:56:22.173 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

11:56:22.173 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 1043: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 220

11:56:22.174 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06

11:56:22.174 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

11:56:22.175 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

11:56:22.175 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1043: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 220

11:56:22.176 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg: ACK

11:56:22.176 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:22.176 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:56:22.180 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 

11:56:22.181 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:56:22.182 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:56:22.182 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1043: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 220

11:56:22.182 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1

11:56:22.183 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: TID 1043: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 220

11:56:22.183 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:56:22.184 [DEBUG] [ol.serialmessage.SendDataMessageClass] - NODE 10: sentData successfully placed on stack.

11:56:22.184 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1043: Advanced to WAIT_REQUEST

11:56:22.185 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: TID 1043: Transaction not completed

11:56:22.185 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:22.186 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:56:22.198 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 DC 00 00 02 35 

11:56:22.199 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=220, payload=DC 00 00 02 

11:56:22.199 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=220, payload=DC 00 00 02 

11:56:22.200 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1043: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 220

11:56:22.200 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1

11:56:22.200 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: TID 1043: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 220

11:56:22.201 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking TID 1043: (Callback 220)

11:56:22.201 [DEBUG] [l.serialmessage.ZWaveCommandProcessor] - Callback match!

11:56:22.201 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Correlated to TID 1043: callback 220

11:56:22.201 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=220, payload=DC 00 00 02 

11:56:22.202 [DEBUG] [ol.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 220, Status = Transmission complete and ACK received(0)

11:56:22.203 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1043: Advanced to WAIT_DATA

11:56:22.203 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: TID 1043: Transaction not completed

11:56:22.203 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:22.204 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:56:27.207 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 10: TID 1043: Timeout at state WAIT_DATA. 3 retries remaining.

11:56:27.208 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 1043: Transaction CANCELLED

11:56:27.208 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

11:56:27.209 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: notifyTransactionResponse TID:1043 CANCELLED

11:56:27.209 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:27.209 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1043: Transaction event listener: DONE: CANCELLED -> 

11:56:27.210 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init response (7) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@59dd7470

11:56:27.210 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: No data from device, but it was ACK'd. Possibly not supported? (Try 7)

11:56:28.152 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:28.153 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.153 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.154 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:28.154 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:28.155 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:28.155 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.155 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:28.156 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:28.156 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:28.156 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:28.157 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:28.157 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:28.818 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:28.819 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.820 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.820 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:28.821 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:28.821 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:28.822 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:28.822 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:28.823 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:28.823 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:28.823 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:28.824 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:28.825 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:29.318 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:29.318 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.319 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.319 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:29.319 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:29.319 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:29.320 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.320 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:29.320 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:29.321 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:29.321 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:29.321 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:29.322 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:56:29.593 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C FE 

11:56:29.593 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.594 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.594 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction null

11:56:29.594 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0

11:56:29.594 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: null

11:56:29.594 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 02 01 00 85 2D 7C 77 82 73 86 72 91 EF 2B 2C 

11:56:29.595 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null

11:56:29.595 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unsupported command class COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE

11:56:29.595 [DEBUG] [otocol.commandclass.ZWaveCommandClass] - NODE 10: Unknown command class 0x91

11:56:29.595 [DEBUG] [message.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.

11:56:29.596 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:56:29.596 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:58:07.929 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: ZWaveCommandClassTransactionPayload - send to node

11:58:07.930 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 10: SECURITY not supported

11:58:07.930 [DEBUG] [ing.zwave.internal.protocol.ZWaveNode] - NODE 10: Command Class COMMAND_CLASS_VERSION is NOT required to be secured

11:58:07.931 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@512bc2f3

11:58:07.931 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: Adding to device queue

11:58:07.932 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: Added 1044 to queue - size 2

11:58:07.932 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:58:07.933 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0A 03 86 13 2C 25 DD AE 

11:58:07.933 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - NODE 10: Sending REQUEST Message = 01 0A 00 13 0A 03 86 13 2C 25 DD AE 

11:58:07.933 [DEBUG] [ding.zwave.handler.ZWaveSerialHandler] - Message SENT

11:58:07.934 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 1044: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 221

11:58:07.935 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06

11:58:07.935 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

11:58:07.935 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

11:58:07.936 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1044: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 221

11:58:07.936 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg: ACK

11:58:07.936 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:58:07.937 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:58:07.941 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 

11:58:07.942 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:58:07.942 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:58:07.942 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1044: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 221

11:58:07.943 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1

11:58:07.943 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: TID 1044: [WAIT_RESPONSE] priority=Config, requiresResponse=true, callback: 221

11:58:07.944 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 

11:58:07.944 [DEBUG] [ol.serialmessage.SendDataMessageClass] - NODE 10: sentData successfully placed on stack.

11:58:07.944 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1044: Advanced to WAIT_REQUEST

11:58:07.945 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: TID 1044: Transaction not completed

11:58:07.945 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:58:07.945 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:58:07.958 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 DD 00 00 02 34 

11:58:07.959 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=221, payload=DD 00 00 02 

11:58:07.959 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=221, payload=DD 00 00 02 

11:58:07.960 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - lastTransaction TID 1044: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 221

11:58:07.960 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1

11:58:07.961 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Last transaction: TID 1044: [WAIT_REQUEST] priority=Config, requiresResponse=true, callback: 221

11:58:07.961 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Checking TID 1044: (Callback 221)

11:58:07.961 [DEBUG] [l.serialmessage.ZWaveCommandProcessor] - Callback match!

11:58:07.962 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Correlated to TID 1044: callback 221

11:58:07.962 [DEBUG] [ave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=221, payload=DD 00 00 02 

11:58:07.962 [DEBUG] [ol.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 221, Status = Transmission complete and ACK received(0)

11:58:07.963 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1044: Advanced to WAIT_DATA

11:58:07.963 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: TID 1044: Transaction not completed

11:58:07.964 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

11:58:07.964 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

11:58:12.968 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 10: TID 1044: Timeout at state WAIT_DATA. 3 retries remaining.

11:58:12.968 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 1044: Transaction CANCELLED

11:58:12.968 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

11:58:12.969 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: notifyTransactionResponse TID:1044 CANCELLED

11:58:12.969 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

11:58:12.969 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1044: Transaction event listener: DONE: CANCELLED -> 

11:58:12.970 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init response (8) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@760079a3

11:58:12.970 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: No data from device, but it was ACK'd. Possibly not supported? (Try 8)

Logs when setting association groups refer to unknown association groups

12:02:47.627 [DEBUG] [ol.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 228, Status = Transmission complete and ACK received(0)

12:02:47.627 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1051: Advanced to WAIT_DATA

12:02:47.627 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: TID 1051: Transaction not completed

12:02:47.628 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

12:02:47.628 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

12:02:52.631 [DEBUG] [nsactionManager$ZWaveTransactionTimer] - NODE 10: TID 1051: Timeout at state WAIT_DATA. 3 retries remaining.

12:02:52.631 [DEBUG] [ve.internal.protocol.ZWaveTransaction] - TID 1051: Transaction CANCELLED

12:02:52.632 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

12:02:52.632 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - NODE 10: notifyTransactionResponse TID:1051 CANCELLED

12:02:52.633 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

12:02:52.633 [DEBUG] [rnal.protocol.ZWaveTransactionManager] - TID 1051: Transaction event listener: DONE: CANCELLED -> 

12:02:52.634 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init response (5) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@383ccce0

12:02:52.634 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 10: No data from device, but it was ACK'd. Possibly not supported? (Try 5)

12:02:57.225 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Configuration update received

12:02:57.226 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Configuration update set group_4 to [controller] (ArrayList)

12:02:57.227 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Unknown association group 4

12:02:57.227 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Configuration update set group_1 to [controller] (ArrayList)

12:02:57.227 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Unknown association group 1

12:02:57.228 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Configuration update set group_3 to [controller] (ArrayList)

12:02:57.228 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Unknown association group 3

12:02:57.228 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Configuration update set group_2 to [controller] (ArrayList)

12:02:57.228 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 10: Unknown association group 2

12:02:57.230 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'zwave:device:050e0827:node10' has been updated.

12:02:57.231 [INFO ] [smarthome.event.ConfigStatusInfoEvent] - ConfigStatusInfo [configStatusMessages=[]]

Sorry, I just realized this is not a battery powered device, so there is no manual wakeup :sunglasses:
https://www.cd-jackson.com/index.php/zwave/zwave-device-database/zwave-device-list/devicesummary/197
Could you please provide the device type, device id and firmware version (application version) of your device.
You should be able to find those in the xml file of your /userdata/zwave folder. You could also post the complete xml file here.

Here is my xml file

<node>
  <homeId>0xee731e50</homeId>
  <nodeId>10</nodeId>
  <version>4</version>
  <manufacturer>0x1d</manufacturer>
  <deviceId>0x261</deviceId>
  <deviceType>0x802</deviceType>
  <listening>true</listening>
  <frequentlyListening>false</frequentlyListening>
  <routing>true</routing>
  <security>false</security>
  <beaming>false</beaming>
  <maxBaudRate>40000</maxBaudRate>
  <sleepDelay>1000</sleepDelay>
  <nodeInformationFrame>
    <commandClass>COMMAND_CLASS_ASSOCIATION</commandClass>
    <commandClass>COMMAND_CLASS_SCENE_CONTROLLER_CONF</commandClass>
    <commandClass>COMMAND_CLASS_REMOTE_ASSOCIATION_ACTIVATE</commandClass>
    <commandClass>COMMAND_CLASS_NODE_NAMING</commandClass>
    <commandClass>COMMAND_CLASS_HAIL</commandClass>
    <commandClass>COMMAND_CLASS_POWERLEVEL</commandClass>
    <commandClass>COMMAND_CLASS_VERSION</commandClass>
    <commandClass>COMMAND_CLASS_MANUFACTURER_SPECIFIC</commandClass>
    <commandClass>COMMAND_CLASS_MANUFACTURER_PROPRIETARY</commandClass>
    <commandClass>COMMAND_CLASS_MARK</commandClass>
    <commandClass>COMMAND_CLASS_SCENE_ACTIVATION</commandClass>
    <commandClass>COMMAND_CLASS_SCENE_ACTUATOR_CONF</commandClass>
  </nodeInformationFrame>
  <associationGroups class="concurrent-hash-map"/>
  <endpoints class="concurrent-hash-map">
    <entry>
      <int>0</int>
      <endPoint>
        <deviceClass>
          <basicDeviceClass>BASIC_TYPE_STATIC_CONTROLLER</basicDeviceClass>
          <genericDeviceClass>GENERIC_TYPE_GENERIC_CONTROLLER</genericDeviceClass>
          <specificDeviceClass>SPECIFIC_TYPE_NOT_USED</specificDeviceClass>
        </deviceClass>
        <endpointId>0</endpointId>
        <secureCommandClasses/>
        <supportedCommandClasses class="concurrent-hash-map">
          <entry>
            <commandClass>COMMAND_CLASS_SCENE_ACTUATOR_CONF</commandClass>
            <COMMAND__CLASS__SCENE__ACTUATOR__CONF>
              <version>0</version>
              <instances>1</instances>
              <control>true</control>
              <versionSupported>0</versionSupported>
            </COMMAND__CLASS__SCENE__ACTUATOR__CONF>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_NODE_NAMING</commandClass>
            <COMMAND__CLASS__NODE__NAMING>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <name></name>
              <location></location>
            </COMMAND__CLASS__NODE__NAMING>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_POWERLEVEL</commandClass>
            <COMMAND__CLASS__POWERLEVEL>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <powerLevel>0</powerLevel>
              <powerTimeout>0</powerTimeout>
            </COMMAND__CLASS__POWERLEVEL>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_SCENE_CONTROLLER_CONF</commandClass>
            <COMMAND__CLASS__SCENE__CONTROLLER__CONF>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
            </COMMAND__CLASS__SCENE__CONTROLLER__CONF>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_VERSION</commandClass>
            <COMMAND__CLASS__VERSION>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <libraryType>LIB_CONTROLLER_STATIC</libraryType>
              <protocolVersion>2.97</protocolVersion>
              <applicationVersion>0.2</applicationVersion>
            </COMMAND__CLASS__VERSION>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_MANUFACTURER_SPECIFIC</commandClass>
            <COMMAND__CLASS__MANUFACTURER__SPECIFIC>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <initSerialNumber>false</initSerialNumber>
              <deviceManufacturer>29</deviceManufacturer>
              <deviceType>2050</deviceType>
              <deviceId>609</deviceId>
            </COMMAND__CLASS__MANUFACTURER__SPECIFIC>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_ASSOCIATION</commandClass>
            <COMMAND__CLASS__ASSOCIATION>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <maxGroups>0</maxGroups>
            </COMMAND__CLASS__ASSOCIATION>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_SCENE_ACTIVATION</commandClass>
            <COMMAND__CLASS__SCENE__ACTIVATION>
              <version>0</version>
              <instances>1</instances>
              <control>true</control>
              <versionSupported>0</versionSupported>
            </COMMAND__CLASS__SCENE__ACTIVATION>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_NO_OPERATION</commandClass>
            <COMMAND__CLASS__NO__OPERATION>
              <version>1</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>1</versionSupported>
            </COMMAND__CLASS__NO__OPERATION>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_HAIL</commandClass>
            <COMMAND__CLASS__HAIL>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
            </COMMAND__CLASS__HAIL>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_BASIC</commandClass>
            <COMMAND__CLASS__BASIC>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <isGetSupported>true</isGetSupported>
            </COMMAND__CLASS__BASIC>
          </entry>
        </supportedCommandClasses>
      </endPoint>
    </entry>
  </endpoints>
  <nodeNeighbors/>
  <lastReceived>2019-06-13 22:21:09.103 UTC</lastReceived>

Your device is in the database:
https://www.cd-jackson.com/index.php/zwave/zwave-device-database/zwave-device-list/devicesummary/197
and has not been updated since 9 month. So it should even work with 2.4 stable.
I can’t find anything wrong in the two seconds debug log either:

I’ve added the zwave tag to your post to attract other zwave users as I don’t know what is wrong here.
Isn’t @mhilbush using this device?