@chris
I have a similar issue with calibration of humidity.
I have 2 of these Multisensor 6 … one is USB powered the other by battery. Both on Firmeare 1.07
For the battery one… Whatever I try to “calibrate” the “HUMIDITY” it just reports the standard humidity and not using the given calibration value from param 202
Here is a debug log for setting 202 to add “8% RH”:
2017-04-23 16:51:39.002 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Configuration update received
2017-04-23 16:51:39.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Configuration update config_202_1 to 8
2017-04-23 16:51:39.198 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 20: Creating new message for application command CONFIGURATIONCMD_SET
2017-04-23 16:51:39.200 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-04-23 16:51:39.200 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-04-23 16:51:39.202 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 20: Creating new message for application command CONFIGURATIONCMD_GET
2017-04-23 16:51:39.203 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 13 14 05 70 04 CA 01 08 25 55 36
2017-04-23 16:51:39.203 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-04-23 16:51:39.206 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 20: Sending REQUEST Message = 01 0C 00 13 14 05 70 04 CA 01 08 25 55 36
2017-04-23 16:51:39.288 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2017-04-23 16:51:39.337 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:39.340 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2017-04-23 16:51:39.342 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2017-04-23 16:51:39.346 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2017-04-23 16:51:39.347 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 20: Sent Data successfully placed on stack.
2017-04-23 16:51:39.399 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 55 00 00 04 BA
2017-04-23 16:51:39.414 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:39.417 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 55 00 00 04 00 00 B4
2017-04-23 16:51:39.420 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 55 00 00 04 00 00 B4
2017-04-23 16:51:39.423 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=55 00 00 04
2017-04-23 16:51:39.425 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 20: SendData Request. CallBack ID = 85, Status = Transmission complete and ACK received(0)
2017-04-23 16:51:39.426 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 20: Starting initialisation from DONE
2017-04-23 16:51:39.427 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1cdb297 already registered
2017-04-23 16:51:39.430 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Config, dest=20, callback=85, payload=14 05 70 04 CA 01 08
2017-04-23 16:51:39.433 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=55 00 00 04
2017-04-23 16:51:39.435 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=85, expected=SendData, cancelled=false transaction complete!
2017-04-23 16:51:39.436 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-04-23 16:51:39.438 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-04-23 16:51:39.439 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 20: Response processed after 232ms/4402ms.
2017-04-23 16:51:39.441 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-04-23 16:51:39.443 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 14 03 70 05 CA 25 56 3D
2017-04-23 16:51:39.447 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 20: Sending REQUEST Message = 01 0A 00 13 14 03 70 05 CA 25 56 3D
2017-04-23 16:51:39.477 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2017-04-23 16:51:39.484 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:39.486 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2017-04-23 16:51:39.488 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2017-04-23 16:51:39.490 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2017-04-23 16:51:39.491 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 20: Sent Data successfully placed on stack.
2017-04-23 16:51:39.511 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 56 00 00 04 B9
2017-04-23 16:51:39.518 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:39.522 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 56 00 00 04 00 00 B7
2017-04-23 16:51:39.525 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 56 00 00 04 00 00 B7
2017-04-23 16:51:39.529 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=56 00 00 04
2017-04-23 16:51:39.532 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 20: SendData Request. CallBack ID = 86, Status = Transmission complete and ACK received(0)
2017-04-23 16:51:39.534 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 20: Starting initialisation from DONE
2017-04-23 16:51:39.537 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1cdb297 already registered
2017-04-23 16:51:39.541 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Config, dest=20, callback=86, payload=14 03 70 05 CA
2017-04-23 16:51:39.544 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=56 00 00 04
2017-04-23 16:51:39.547 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=86, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2017-04-23 16:51:39.566 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 14 05 70 06 CA 01 08 54
2017-04-23 16:51:39.576 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:39.582 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 04 00 14 05 70 06 CA 01 08 54
2017-04-23 16:51:39.588 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0B 00 04 00 14 05 70 06 CA 01 08 54
2017-04-23 16:51:39.594 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 14 05 70 06 CA 01 08
2017-04-23 16:51:39.599 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 20: Application Command Request (ALIVE:DONE)
2017-04-23 16:51:39.604 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 20: Starting initialisation from DONE
2017-04-23 16:51:39.608 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1cdb297 already registered
2017-04-23 16:51:39.612 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 20: Incoming command class CONFIGURATION
2017-04-23 16:51:39.617 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 20: Received Configuration Request
2017-04-23 16:51:39.621 [DEBUG] [class.ZWaveConfigurationCommandClass] - NODE 20: Node configuration report, parameter = 202, value = 8, size = 1
2017-04-23 16:51:39.626 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveConfigurationParameterEvent
2017-04-23 16:51:39.633 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Got an event from Z-Wave network: ZWaveConfigurationParameterEvent
2017-04-23 16:51:39.638 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Got a value event from Z-Wave network, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ZWaveConfigurationParameter@f915c
2017-04-23 16:51:39.642 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Update CONFIGURATION 202/1 to 8
2017-04-23 16:51:39.646 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Config about to update 38 parameters...
2017-04-23 16:51:39.650 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_00FFFF00
2017-04-23 16:51:39.653 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_00FFFF00 len=4
2017-04-23 16:51:39.657 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_00FFFF00 - id = '41'
2017-04-23 16:51:39.660 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_100_1_wo
2017-04-23 16:51:39.663 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_100_1_wo len=4
2017-04-23 16:51:39.667 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_100_1_wo - id = '100'
2017-04-23 16:51:39.671 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing group_org.openhab.binding.zwave.internal.protocol.ZWaveAssociationGroup@1035c1d
2017-04-23 16:51:39.675 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2
2017-04-23 16:51:39.679 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2 len=3
2017-04-23 16:51:39.684 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2 - id = '201'
2017-04-23 16:51:39.688 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_202_1
2017-04-23 16:51:39.692 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_202_1 len=3
2017-04-23 16:51:39.697 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_202_1 - id = '202'
2017-04-23 16:51:39.702 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_202_1 - size = '1'
2017-04-23 16:51:39.707 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Sub-parameter config_202_1 is 00000008
2017-04-23 16:51:39.713 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Pre-processing 00000008>>FFFFFFFF
2017-04-23 16:51:39.719 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Post-processing 00000008>>FFFFFFFF
2017-04-23 16:51:39.724 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Sub-parameter setting config_202_1 is 00000008 [8]
2017-04-23 16:51:39.729 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_203_2
2017-04-23 16:51:39.733 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_203_2 len=3
2017-04-23 16:51:39.737 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_203_2 - id = '203'
2017-04-23 16:51:39.741 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_204_1
2017-04-23 16:51:39.745 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_204_1 len=3
2017-04-23 16:51:39.749 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_204_1 - id = '204'
2017-04-23 16:51:39.753 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing group_1
2017-04-23 16:51:39.757 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_0000FF00
2017-04-23 16:51:39.761 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_0000FF00 len=4
2017-04-23 16:51:39.765 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_0000FF00 - id = '201'
2017-04-23 16:51:39.769 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_112_4
2017-04-23 16:51:39.774 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_112_4 len=3
2017-04-23 16:51:39.778 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_112_4 - id = '112'
2017-04-23 16:51:39.781 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing wakeup_node
2017-04-23 16:51:39.786 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_39_1
2017-04-23 16:51:39.791 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_39_1 len=3
2017-04-23 16:51:39.796 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_39_1 - id = '39'
2017-04-23 16:51:39.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_113_4
2017-04-23 16:51:39.807 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_113_4 len=3
2017-04-23 16:51:39.812 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_113_4 - id = '113'
2017-04-23 16:51:39.818 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_111_4
2017-04-23 16:51:39.823 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_111_4 len=3
2017-04-23 16:51:39.828 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_111_4 - id = '111'
2017-04-23 16:51:39.833 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_0000000F
2017-04-23 16:51:39.840 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_0000000F len=4
2017-04-23 16:51:39.845 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3_0000000F - id = '41'
2017-04-23 16:51:39.850 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_42_1
2017-04-23 16:51:39.857 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_42_1 len=3
2017-04-23 16:51:39.862 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_42_1 - id = '42'
2017-04-23 16:51:39.868 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_000000FF
2017-04-23 16:51:39.873 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_000000FF len=4
2017-04-23 16:51:39.880 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_201_2_000000FF - id = '201'
2017-04-23 16:51:39.887 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_43_2
2017-04-23 16:51:39.892 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_43_2 len=3
2017-04-23 16:51:39.897 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_43_2 - id = '43'
2017-04-23 16:51:39.906 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_44_1
2017-04-23 16:51:39.916 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_44_1 len=3
2017-04-23 16:51:39.922 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_44_1 - id = '44'
2017-04-23 16:51:39.927 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3
2017-04-23 16:51:39.935 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3 len=3
2017-04-23 16:51:39.942 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_41_3 - id = '41'
2017-04-23 16:51:39.947 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_40_1
2017-04-23 16:51:39.952 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_40_1 len=3
2017-04-23 16:51:39.958 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_40_1 - id = '40'
2017-04-23 16:51:39.965 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_252_1
2017-04-23 16:51:39.971 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_252_1 len=3
2017-04-23 16:51:39.977 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_252_1 - id = '252'
2017-04-23 16:51:39.982 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing wakeup_interval
2017-04-23 16:51:39.987 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing powerlevel_level
2017-04-23 16:51:39.994 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_110_1_wo
2017-04-23 16:51:39.999 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_110_1_wo len=4
2017-04-23 16:51:40.006 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_110_1_wo - id = '110'
2017-04-23 16:51:40.012 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_255_4_wo
2017-04-23 16:51:40.017 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_255_4_wo len=4
2017-04-23 16:51:40.023 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_255_4_wo - id = '255'
2017-04-23 16:51:40.030 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_2_1
2017-04-23 16:51:40.036 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_2_1 len=3
2017-04-23 16:51:40.042 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_2_1 - id = '2'
2017-04-23 16:51:40.059 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_101_4
2017-04-23 16:51:40.064 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_101_4 len=3
2017-04-23 16:51:40.069 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_101_4 - id = '101'
2017-04-23 16:51:40.074 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_102_4
2017-04-23 16:51:40.079 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_102_4 len=3
2017-04-23 16:51:40.085 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_102_4 - id = '102'
2017-04-23 16:51:40.090 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing powerlevel_timeout
2017-04-23 16:51:40.095 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_9_2
2017-04-23 16:51:40.100 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_9_2 len=3
2017-04-23 16:51:40.105 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_9_2 - id = '9'
2017-04-23 16:51:40.110 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_46_1
2017-04-23 16:51:40.115 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_46_1 len=3
2017-04-23 16:51:40.120 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_46_1 - id = '46'
2017-04-23 16:51:40.125 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing group_org.openhab.binding.zwave.internal.protocol.ZWaveAssociationGroup@da8e6e
2017-04-23 16:51:40.129 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_3_2
2017-04-23 16:51:40.134 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_3_2 len=3
2017-04-23 16:51:40.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_3_2 - id = '3'
2017-04-23 16:51:40.142 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_4_1
2017-04-23 16:51:40.147 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_4_1 len=3
2017-04-23 16:51:40.151 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_4_1 - id = '4'
2017-04-23 16:51:40.155 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_45_1
2017-04-23 16:51:40.159 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_45_1 len=3
2017-04-23 16:51:40.163 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_45_1 - id = '45'
2017-04-23 16:51:40.167 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_5_1
2017-04-23 16:51:40.171 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_5_1 len=3
2017-04-23 16:51:40.176 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_5_1 - id = '5'
2017-04-23 16:51:40.180 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_103_4
2017-04-23 16:51:40.184 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_103_4 len=3
2017-04-23 16:51:40.188 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Processing config_103_4 - id = '103'
2017-04-23 16:51:40.193 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Config, dest=20, callback=86, payload=14 03 70 05 CA
2017-04-23 16:51:40.199 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 14 05 70 06 CA 01 08
2017-04-23 16:51:40.203 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=86, expected=ApplicationCommandHandler, cancelled=false transaction complete!
2017-04-23 16:51:40.207 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-04-23 16:51:40.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 20: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-04-23 16:51:40.216 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 20: Response processed after 768ms/4402ms.
2017-04-23 16:51:41.117 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 1F 00 04 00 13 19 8F 01 04 03 80 03 64 04 30 03 FF 0C 05 31 05 03 01 32 06 31 05 01 22 00 AA FE
2017-04-23 16:51:41.129 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-04-23 16:51:41.135 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 1F 00 04 00 13 19 8F 01 04 03 80 03 64 04 30 03 FF 0C 05 31 05 03 01 32 06 31 05 01 22 00 AA FE
2017-04-23 16:51:41.143 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 1F 00 04 00 13 19 8F 01 04 03 80 03 64 04 30 03 FF 0C 05 31 05 03 01 32 06 31 05 01 22 00 AA FE
2017-04-23 16:51:41.151 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 13 19 8F 01 04 03 80 03 64 04 30 03 FF 0C 05 31 05 03 01 32 06 31 05 01 22 00 AA
2017-04-23 16:51:41.156 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 19: Application Command Request (ALIVE:DONE)
2017-04-23 16:51:41.161 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 19: Starting initialisation from DONE
2017-04-23 16:51:41.166 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@149864c already registered
2017-04-23 16:51:41.171 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 19: Incoming command class MULTI_CMD
2017-04-23 16:51:41.177 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Received Multi-Command Request
2017-04-23 16:51:41.184 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Incoming command class BATTERY
2017-04-23 16:51:41.189 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Calling handleApplicationCommandRequest.
2017-04-23 16:51:41.193 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 19: Received Battery Request
2017-04-23 16:51:41.198 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 19: Battery report value = 100
2017-04-23 16:51:41.209 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2017-04-23 16:51:41.220 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2017-04-23 16:51:41.229 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got a value event from Z-Wave network, endpoint = 0, command class = BATTERY, value = 100
2017-04-23 16:51:41.235 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Updating channel state zwave:device:15348538564:node19:battery-level to 100 [DecimalType]
2017-04-23 16:51:41.266 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Incoming command class SENSOR_BINARY
2017-04-23 16:51:41.267 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Calling handleApplicationCommandRequest.
2017-04-23 16:51:41.275 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 19: Received SENSOR_BINARY command V2
2017-04-23 16:51:41.276 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - Processing Sensor Type 12
2017-04-23 16:51:41.277 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - Sensor Type is MOTION
2017-04-23 16:51:41.278 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 19: Sensor Binary report, type=Motion, value=255
2017-04-23 16:51:41.279 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveBinarySensorValueEvent
2017-04-23 16:51:41.280 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got an event from Z-Wave network: ZWaveBinarySensorValueEvent
2017-04-23 16:51:41.282 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got a value event from Z-Wave network, endpoint = 0, command class = SENSOR_BINARY, value = 255
2017-04-23 16:51:41.283 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Updating channel state zwave:device:15348538564:node19:alarm_motion to ON [OnOffType]
2017-04-23 16:51:41.297 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Incoming command class SENSOR_MULTILEVEL
2017-04-23 16:51:41.298 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Calling handleApplicationCommandRequest.
2017-04-23 16:51:41.300 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Received COMMAND_CLASS_SENSOR_MULTILEVEL command V5
2017-04-23 16:51:41.301 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Multi Level REPORT received
2017-04-23 16:51:41.302 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Type = Luminance(3), Scale = 0
2017-04-23 16:51:41.310 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Value = 5E+1
2017-04-23 16:51:41.312 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
2017-04-23 16:51:41.313 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2017-04-23 16:51:41.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got a value event from Z-Wave network, endpoint = 0, command class = SENSOR_MULTILEVEL, value = 5E+1
2017-04-23 16:51:41.316 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Updating channel state zwave:device:15348538564:node19:sensor_luminance to 50 [DecimalType]
2017-04-23 16:51:41.354 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Incoming command class SENSOR_MULTILEVEL
2017-04-23 16:51:41.355 [DEBUG] [dclass.ZWaveMultiCommandCommandClass] - NODE 19: Calling handleApplicationCommandRequest.
2017-04-23 16:51:41.356 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Received COMMAND_CLASS_SENSOR_MULTILEVEL command V5
2017-04-23 16:51:41.357 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Multi Level REPORT received
2017-04-23 16:51:41.360 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Type = Temperature(1), Scale = 0
2017-04-23 16:51:41.366 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 19: Sensor Value = 17
2017-04-23 16:51:41.372 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
2017-04-23 16:51:41.377 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2017-04-23 16:51:41.380 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got a value event from Z-Wave network, endpoint = 0, command class = SENSOR_MULTILEVEL, value = 17
2017-04-23 16:51:41.382 [INFO ] [e.smarthome.model.script.ALARMANLAGE] - Step 1a - Find Reason
2017-04-23 16:51:41.386 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 19: Sensor is reporting scale 0, requiring conversion to 0. Value is now 17.
2017-04-23 16:51:41.387 [DEBUG] [converter.ZWaveCommandClassConverter] - Converted temperature from 17C to 17C
2017-04-23 16:51:41.388 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Updating channel state zwave:device:15348538564:node19:sensor_temperature to 17 [DecimalType]
2017-04-23 16:51:41.436 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 20: Transaction not completed: node address inconsistent. lastSent=20, incoming=255