DEBUG 2019-10-14 16:37:42,924 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[02, C1, B4, 4E, CE, 78, 30, 97]] succeeded
DEBUG 2019-10-14 16:37:42,995 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:43,001 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x28, 0xB8, 0xCE, 0x14, 0xFA, 0xBE, 0x44, 0x52, 0x60, 0x7F, 0x89, 0x3D, 0xE8, 0x74, 0xB7, 0x24, 0xC4, 0xF0, 0x01, 0x02, 0xA8, 0x1E, 0x25, 0x42, 0x8D, 0xF0, 0xF4, 0x13, 0x2D]
DEBUG 2019-10-14 16:37:43,007 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:43,009 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x28, 0xB8, 0xCE, 0x14, 0xFA, 0xBE, 0x44, 0x52, 0x60, 0x7F, 0x89, 0x3D, 0xE8, 0x74, 0xB7, 0x24, 0xC4, 0xF0, 0x01, 0x02, 0xA8, 0x1E, 0x25, 0x42, 0x8D, 0xF0, 0xF4, 0x13, 0x2D] has been received.
DEBUG 2019-10-14 16:37:43,012 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x28, 0xB8, 0xCE, 0x14, 0xFA, 0xBE, 0x44, 0x52, 0x60, 0x7F, 0x89, 0x3D, 0xE8, 0x74, 0xB7, 0x24, 0xC4, 0xF0, 0x01, 0x02, 0xA8, 0x1E, 0x25, 0x42, 0x8D, 0xF0, 0xF4, 0x13]]
DEBUG 2019-10-14 16:37:43,015 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x16, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:43,017 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_OPEN', Dec:'22', Hex: '0x16']].
DEBUG 2019-10-14 16:37:45,003 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:45,004 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:45,005 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:45,005 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:45,006 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:45,007 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:45,008 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[C7, 4E, CF, CC, CB, 24, 85, A5]]
DEBUG 2019-10-14 16:37:45,010 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:45,010 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:45,011 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:45,012 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x20)' request (callback ID=0x20).
DEBUG 2019-10-14 16:37:45,014 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5, 0x05, 0x20, 0xBA].
DEBUG 2019-10-14 16:37:45,015 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:45,020 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:45,020 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:45,021 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:45,021 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:45,021 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:45,022 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:45,022 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:45,023 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC7]
DEBUG 2019-10-14 16:37:45,023 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4E]
DEBUG 2019-10-14 16:37:45,023 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xCF]
DEBUG 2019-10-14 16:37:45,024 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xCC]
DEBUG 2019-10-14 16:37:45,024 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xCB]
DEBUG 2019-10-14 16:37:45,025 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x24]
DEBUG 2019-10-14 16:37:45,025 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x85]
DEBUG 2019-10-14 16:37:45,026 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xA5]
DEBUG 2019-10-14 16:37:45,026 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:45,026 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x20]
DEBUG 2019-10-14 16:37:45,027 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xBA]
DEBUG 2019-10-14 16:37:45,028 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:45,029 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5, 0x05, 0x20, 0xBA] transmission OK.
DEBUG 2019-10-14 16:37:45,031 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x20)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:45,033 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:45,034 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:45,035 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:45,036 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x20).
DEBUG 2019-10-14 16:37:45,036 (Z-Wave): RX_Session_Layer            : Waiting 64,976 [ms] for 'ZW_SendData' callback frame (callback ID=0x20).
DEBUG 2019-10-14 16:37:45,035 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:45,118 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:45,119 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x20, 0x00, 0x00, 0x08, 0xC3]
DEBUG 2019-10-14 16:37:45,120 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:45,120 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x20, 0x00, 0x00, 0x08, 0xC3] has been received.
DEBUG 2019-10-14 16:37:45,122 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x20, 0x00, 0x00, 0x08, 0xC3] (callback ID=0x20) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC7, 0x4E, 0xCF, 0xCC, 0xCB, 0x24, 0x85, 0xA5], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x20)' successfully executed.
DEBUG 2019-10-14 16:37:45,123 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[C7, 4E, CF, CC, CB, 24, 85, A5]] succeeded
DEBUG 2019-10-14 16:37:45,195 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:45,196 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x1B, 0x34, 0xC1, 0x48, 0xE6, 0x29, 0x1C, 0xE0, 0x94, 0xFB, 0x7A, 0xDD]
DEBUG 2019-10-14 16:37:45,198 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x7A, 0xAA, 0x47, 0x00, 0xCF, 0xBB, 0x19, 0xC7, 0xF6, 0x07, 0xFF, 0xC8, 0xF1, 0x5C, 0x15, 0x75, 0x86]
DEBUG 2019-10-14 16:37:45,199 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:45,201 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x1B, 0x34, 0xC1, 0x48, 0xE6, 0x29, 0x1C, 0xE0, 0x94, 0xFB, 0x7A, 0xDD, 0x7A, 0xAA, 0x47, 0x00, 0xCF, 0xBB, 0x19, 0xC7, 0xF6, 0x07, 0xFF, 0xC8, 0xF1, 0x5C, 0x15, 0x75, 0x86] has been received.
DEBUG 2019-10-14 16:37:45,204 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x1B, 0x34, 0xC1, 0x48, 0xE6, 0x29, 0x1C, 0xE0, 0x94, 0xFB, 0x7A, 0xDD, 0x7A, 0xAA, 0x47, 0x00, 0xCF, 0xBB, 0x19, 0xC7, 0xF6, 0x07, 0xFF, 0xC8, 0xF1, 0x5C, 0x15, 0x75]]
DEBUG 2019-10-14 16:37:45,208 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x17, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:45,209 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_CLOSE', Dec:'23', Hex: '0x17']].
DEBUG 2019-10-14 16:37:47,203 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:47,204 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:47,205 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:47,205 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:47,207 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:47,207 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:47,208 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[7B, 9F, 91, 42, 6E, 28, 15, 84]]
DEBUG 2019-10-14 16:37:47,210 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:47,210 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:47,211 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:47,213 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x21)' request (callback ID=0x21).
DEBUG 2019-10-14 16:37:47,215 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84, 0x05, 0x21, 0x1E].
DEBUG 2019-10-14 16:37:47,216 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:47,217 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:47,218 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:47,218 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:47,219 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:47,219 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:47,220 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:47,220 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:47,221 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x7B]
DEBUG 2019-10-14 16:37:47,221 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x9F]
DEBUG 2019-10-14 16:37:47,222 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x91]
DEBUG 2019-10-14 16:37:47,222 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x42]
DEBUG 2019-10-14 16:37:47,223 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x6E]
DEBUG 2019-10-14 16:37:47,223 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x28]
DEBUG 2019-10-14 16:37:47,224 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x15]
DEBUG 2019-10-14 16:37:47,224 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x84]
DEBUG 2019-10-14 16:37:47,225 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:47,225 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x21]
DEBUG 2019-10-14 16:37:47,226 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x1E]
DEBUG 2019-10-14 16:37:47,227 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:47,229 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84, 0x05, 0x21, 0x1E] transmission OK.
DEBUG 2019-10-14 16:37:47,231 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x21)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:47,232 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:47,233 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:47,234 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:47,234 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:47,235 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x21).
DEBUG 2019-10-14 16:37:47,235 (Z-Wave): RX_Session_Layer            : Waiting 64,977 [ms] for 'ZW_SendData' callback frame (callback ID=0x21).
DEBUG 2019-10-14 16:37:47,319 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:47,319 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x21, 0x00, 0x00, 0x09, 0xC3]
DEBUG 2019-10-14 16:37:47,320 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:47,320 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x21, 0x00, 0x00, 0x09, 0xC3] has been received.
DEBUG 2019-10-14 16:37:47,321 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x21, 0x00, 0x00, 0x09, 0xC3] (callback ID=0x21) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x7B, 0x9F, 0x91, 0x42, 0x6E, 0x28, 0x15, 0x84], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x21)' successfully executed.
DEBUG 2019-10-14 16:37:47,321 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[7B, 9F, 91, 42, 6E, 28, 15, 84]] succeeded
DEBUG 2019-10-14 16:37:47,395 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:47,396 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x59, 0x38, 0x8A, 0x49, 0x50, 0xD0, 0xB1, 0x3A, 0x18]
DEBUG 2019-10-14 16:37:47,397 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0xB8, 0x9F, 0xF6, 0xC6, 0x53, 0xB4, 0x7C, 0xFC, 0xED, 0x14, 0x7B, 0xE9, 0xB8, 0x68, 0xB4, 0xAA, 0x3B, 0xB9, 0x7B, 0x70]
DEBUG 2019-10-14 16:37:47,398 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:47,398 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x59, 0x38, 0x8A, 0x49, 0x50, 0xD0, 0xB1, 0x3A, 0x18, 0xB8, 0x9F, 0xF6, 0xC6, 0x53, 0xB4, 0x7C, 0xFC, 0xED, 0x14, 0x7B, 0xE9, 0xB8, 0x68, 0xB4, 0xAA, 0x3B, 0xB9, 0x7B, 0x70] has been received.
DEBUG 2019-10-14 16:37:47,400 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x59, 0x38, 0x8A, 0x49, 0x50, 0xD0, 0xB1, 0x3A, 0x18, 0xB8, 0x9F, 0xF6, 0xC6, 0x53, 0xB4, 0x7C, 0xFC, 0xED, 0x14, 0x7B, 0xE9, 0xB8, 0x68, 0xB4, 0xAA, 0x3B, 0xB9, 0x7B]]
DEBUG 2019-10-14 16:37:47,402 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x16, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:47,403 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_OPEN', Dec:'22', Hex: '0x16']].
DEBUG 2019-10-14 16:37:48,703 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:48,704 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:48,705 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:48,705 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:48,706 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:48,707 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:48,708 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[C8, 8C, B2, 0C, 1E, 74, D8, DC]]
DEBUG 2019-10-14 16:37:48,709 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:48,709 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:48,710 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:48,711 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' request (callback ID=0x22).
DEBUG 2019-10-14 16:37:48,712 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC, 0x05, 0x22, 0x69].
DEBUG 2019-10-14 16:37:48,713 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:48,714 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:48,714 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:48,715 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:48,715 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:48,716 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:48,716 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:48,716 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:48,717 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC8]
DEBUG 2019-10-14 16:37:48,717 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x8C]
DEBUG 2019-10-14 16:37:48,718 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB2]
DEBUG 2019-10-14 16:37:48,718 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0C]
DEBUG 2019-10-14 16:37:48,718 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x1E]
DEBUG 2019-10-14 16:37:48,719 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x74]
DEBUG 2019-10-14 16:37:48,719 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xD8]
DEBUG 2019-10-14 16:37:48,720 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xDC]
DEBUG 2019-10-14 16:37:48,720 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:48,721 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x22]
DEBUG 2019-10-14 16:37:48,721 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x69]
DEBUG 2019-10-14 16:37:48,721 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:48,722 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC, 0x05, 0x22, 0x69] transmission OK.
DEBUG 2019-10-14 16:37:48,724 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:48,728 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:48,729 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:48,729 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:48,730 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:48,730 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x22).
DEBUG 2019-10-14 16:37:48,730 (Z-Wave): RX_Session_Layer            : Waiting 64,980 [ms] for 'ZW_SendData' callback frame (callback ID=0x22).
DEBUG 2019-10-14 16:37:48,818 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:48,819 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x22, 0x00, 0x00, 0x09, 0xC0]
DEBUG 2019-10-14 16:37:48,819 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x22, 0x00, 0x00, 0x09, 0xC0] has been received.
DEBUG 2019-10-14 16:37:48,819 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:48,821 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x22, 0x00, 0x00, 0x09, 0xC0] (callback ID=0x22) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xC8, 0x8C, 0xB2, 0x0C, 0x1E, 0x74, 0xD8, 0xDC], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' successfully executed.
DEBUG 2019-10-14 16:37:48,821 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[C8, 8C, B2, 0C, 1E, 74, D8, DC]] succeeded
DEBUG 2019-10-14 16:37:48,895 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:48,897 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x13, 0x2A, 0x92, 0xF9, 0x98, 0xD2, 0x04, 0x43, 0xEC, 0x3C, 0x87, 0xF9, 0xF9, 0x32, 0x9A, 0x5E]
DEBUG 2019-10-14 16:37:48,898 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x99, 0x86, 0x9B, 0xC8, 0x82, 0x43, 0x37, 0xB7, 0x43, 0x49, 0xF9, 0x1F, 0xF2]
DEBUG 2019-10-14 16:37:48,899 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:48,900 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x13, 0x2A, 0x92, 0xF9, 0x98, 0xD2, 0x04, 0x43, 0xEC, 0x3C, 0x87, 0xF9, 0xF9, 0x32, 0x9A, 0x5E, 0x99, 0x86, 0x9B, 0xC8, 0x82, 0x43, 0x37, 0xB7, 0x43, 0x49, 0xF9, 0x1F, 0xF2] has been received.
DEBUG 2019-10-14 16:37:48,902 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x13, 0x2A, 0x92, 0xF9, 0x98, 0xD2, 0x04, 0x43, 0xEC, 0x3C, 0x87, 0xF9, 0xF9, 0x32, 0x9A, 0x5E, 0x99, 0x86, 0x9B, 0xC8, 0x82, 0x43, 0x37, 0xB7, 0x43, 0x49, 0xF9, 0x1F]]
DEBUG 2019-10-14 16:37:48,905 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x17, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:48,906 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_CLOSE', Dec:'23', Hex: '0x17']].
DEBUG 2019-10-14 16:37:50,603 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:50,604 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:50,605 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:50,605 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:50,606 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:50,607 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:50,607 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[83, 84, B2, 26, B5, 4A, 27, DA]]
DEBUG 2019-10-14 16:37:50,608 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:50,608 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:50,626 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:50,628 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' request (callback ID=0x23).
DEBUG 2019-10-14 16:37:50,629 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA, 0x05, 0x23, 0x6D].
DEBUG 2019-10-14 16:37:50,630 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:50,630 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:50,631 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:50,631 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:50,631 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:50,632 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:50,632 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:50,633 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:50,633 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x83]
DEBUG 2019-10-14 16:37:50,633 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x84]
DEBUG 2019-10-14 16:37:50,634 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB2]
DEBUG 2019-10-14 16:37:50,634 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:37:50,635 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB5]
DEBUG 2019-10-14 16:37:50,635 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4A]
DEBUG 2019-10-14 16:37:50,635 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x27]
DEBUG 2019-10-14 16:37:50,636 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xDA]
DEBUG 2019-10-14 16:37:50,636 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:50,637 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x23]
DEBUG 2019-10-14 16:37:50,637 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x6D]
DEBUG 2019-10-14 16:37:50,638 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:50,639 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA, 0x05, 0x23, 0x6D] transmission OK.
DEBUG 2019-10-14 16:37:50,640 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:50,643 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:50,644 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:50,644 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:50,644 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:50,645 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x23).
DEBUG 2019-10-14 16:37:50,645 (Z-Wave): RX_Session_Layer            : Waiting 64,982 [ms] for 'ZW_SendData' callback frame (callback ID=0x23).
DEBUG 2019-10-14 16:37:50,718 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:50,719 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x23, 0x00, 0x00, 0x07, 0xCF]
DEBUG 2019-10-14 16:37:50,720 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x23, 0x00, 0x00, 0x07, 0xCF] has been received.
DEBUG 2019-10-14 16:37:50,720 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:50,721 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x23, 0x00, 0x00, 0x07, 0xCF] (callback ID=0x23) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x83, 0x84, 0xB2, 0x26, 0xB5, 0x4A, 0x27, 0xDA], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' successfully executed.
DEBUG 2019-10-14 16:37:50,722 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[83, 84, B2, 26, B5, 4A, 27, DA]] succeeded
DEBUG 2019-10-14 16:37:50,795 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:50,796 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xE9, 0xD6, 0x85, 0x4F, 0xD1, 0x03, 0xD3, 0xCA, 0x34]
DEBUG 2019-10-14 16:37:50,797 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x7E, 0x5E, 0xDA, 0xF4, 0x92, 0xEC, 0xCD, 0x1F, 0x1C, 0xAC, 0x83, 0x6A, 0xA1, 0xE7, 0x7F, 0x24, 0x8A, 0xBD, 0xF5]
DEBUG 2019-10-14 16:37:50,797 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0xC3]
DEBUG 2019-10-14 16:37:50,798 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:50,799 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xE9, 0xD6, 0x85, 0x4F, 0xD1, 0x03, 0xD3, 0xCA, 0x34, 0x7E, 0x5E, 0xDA, 0xF4, 0x92, 0xEC, 0xCD, 0x1F, 0x1C, 0xAC, 0x83, 0x6A, 0xA1, 0xE7, 0x7F, 0x24, 0x8A, 0xBD, 0xF5, 0xC3] has been received.
DEBUG 2019-10-14 16:37:50,801 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0xE9, 0xD6, 0x85, 0x4F, 0xD1, 0x03, 0xD3, 0xCA, 0x34, 0x7E, 0x5E, 0xDA, 0xF4, 0x92, 0xEC, 0xCD, 0x1F, 0x1C, 0xAC, 0x83, 0x6A, 0xA1, 0xE7, 0x7F, 0x24, 0x8A, 0xBD, 0xF5]]
DEBUG 2019-10-14 16:37:50,803 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x16, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:50,804 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_OPEN', Dec:'22', Hex: '0x16']].
DEBUG 2019-10-14 16:37:52,003 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:52,004 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:52,005 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:52,005 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:52,006 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:52,006 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:52,007 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[3A, 83, 9E, F7, 34, 34, D0, 97]]
DEBUG 2019-10-14 16:37:52,008 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:52,008 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:52,009 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:52,010 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' request (callback ID=0x24).
DEBUG 2019-10-14 16:37:52,011 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97, 0x05, 0x24, 0x6C].
DEBUG 2019-10-14 16:37:52,011 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:52,012 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:52,012 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:52,013 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:52,013 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:52,013 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:52,014 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:52,014 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:52,014 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x3A]
DEBUG 2019-10-14 16:37:52,015 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x83]
DEBUG 2019-10-14 16:37:52,015 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x9E]
DEBUG 2019-10-14 16:37:52,016 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xF7]
DEBUG 2019-10-14 16:37:52,016 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x34]
DEBUG 2019-10-14 16:37:52,016 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x34]
DEBUG 2019-10-14 16:37:52,017 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xD0]
DEBUG 2019-10-14 16:37:52,017 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x97]
DEBUG 2019-10-14 16:37:52,017 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:52,018 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x24]
DEBUG 2019-10-14 16:37:52,018 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x6C]
DEBUG 2019-10-14 16:37:52,019 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:52,020 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97, 0x05, 0x24, 0x6C] transmission OK.
DEBUG 2019-10-14 16:37:52,021 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:52,024 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:52,025 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:52,026 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:52,026 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:52,026 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x24).
DEBUG 2019-10-14 16:37:52,027 (Z-Wave): RX_Session_Layer            : Waiting 64,983 [ms] for 'ZW_SendData' callback frame (callback ID=0x24).
DEBUG 2019-10-14 16:37:52,117 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:52,118 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x24, 0x00, 0x00, 0x09, 0xC6]
DEBUG 2019-10-14 16:37:52,119 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x24, 0x00, 0x00, 0x09, 0xC6] has been received.
DEBUG 2019-10-14 16:37:52,119 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:52,120 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x24, 0x00, 0x00, 0x09, 0xC6] (callback ID=0x24) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3A, 0x83, 0x9E, 0xF7, 0x34, 0x34, 0xD0, 0x97], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' successfully executed.
DEBUG 2019-10-14 16:37:52,121 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[3A, 83, 9E, F7, 34, 34, D0, 97]] succeeded
DEBUG 2019-10-14 16:37:52,195 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:52,197 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xE5, 0x93, 0x12, 0x6E, 0x70, 0x6E, 0x1A, 0x3E, 0xB0, 0x49, 0xDB, 0x1D, 0x33, 0x32, 0xEA, 0x74, 0x6A, 0xF3, 0xA8, 0x3A, 0xD0, 0x93]
DEBUG 2019-10-14 16:37:52,197 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x8C, 0x10, 0x1E, 0x20, 0x3D, 0x42, 0xE8]
DEBUG 2019-10-14 16:37:52,198 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:52,199 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xE5, 0x93, 0x12, 0x6E, 0x70, 0x6E, 0x1A, 0x3E, 0xB0, 0x49, 0xDB, 0x1D, 0x33, 0x32, 0xEA, 0x74, 0x6A, 0xF3, 0xA8, 0x3A, 0xD0, 0x93, 0x8C, 0x10, 0x1E, 0x20, 0x3D, 0x42, 0xE8] has been received.
DEBUG 2019-10-14 16:37:52,201 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0xE5, 0x93, 0x12, 0x6E, 0x70, 0x6E, 0x1A, 0x3E, 0xB0, 0x49, 0xDB, 0x1D, 0x33, 0x32, 0xEA, 0x74, 0x6A, 0xF3, 0xA8, 0x3A, 0xD0, 0x93, 0x8C, 0x10, 0x1E, 0x20, 0x3D, 0x42]]
DEBUG 2019-10-14 16:37:52,204 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x17, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:52,205 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_CLOSE', Dec:'23', Hex: '0x17']].
DEBUG 2019-10-14 16:37:54,303 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:54,304 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:54,304 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:54,304 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:54,305 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:54,306 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:54,306 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[33, 08, 91, 22, 9F, C6, F7, 4C]]
DEBUG 2019-10-14 16:37:54,307 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:54,307 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:54,308 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:54,309 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' request (callback ID=0x25).
DEBUG 2019-10-14 16:37:54,310 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C, 0x05, 0x25, 0x90].
DEBUG 2019-10-14 16:37:54,311 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:54,311 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:54,311 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:54,312 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:54,312 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:54,313 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:54,313 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:54,314 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:54,314 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x33]
DEBUG 2019-10-14 16:37:54,314 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x08]
DEBUG 2019-10-14 16:37:54,315 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x91]
DEBUG 2019-10-14 16:37:54,315 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x22]
DEBUG 2019-10-14 16:37:54,315 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x9F]
DEBUG 2019-10-14 16:37:54,316 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC6]
DEBUG 2019-10-14 16:37:54,316 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xF7]
DEBUG 2019-10-14 16:37:54,317 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4C]
DEBUG 2019-10-14 16:37:54,317 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:54,317 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:37:54,318 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x90]
DEBUG 2019-10-14 16:37:54,319 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:54,320 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C, 0x05, 0x25, 0x90] transmission OK.
DEBUG 2019-10-14 16:37:54,321 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:54,324 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:54,325 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:54,325 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:54,325 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:54,326 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x25).
DEBUG 2019-10-14 16:37:54,326 (Z-Wave): RX_Session_Layer            : Waiting 64,983 [ms] for 'ZW_SendData' callback frame (callback ID=0x25).
DEBUG 2019-10-14 16:37:54,418 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:54,419 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x25, 0x00, 0x00, 0x09, 0xC7]
DEBUG 2019-10-14 16:37:54,419 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:54,419 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x25, 0x00, 0x00, 0x09, 0xC7] has been received.
DEBUG 2019-10-14 16:37:54,421 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x25, 0x00, 0x00, 0x09, 0xC7] (callback ID=0x25) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x33, 0x08, 0x91, 0x22, 0x9F, 0xC6, 0xF7, 0x4C], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' successfully executed.
DEBUG 2019-10-14 16:37:54,421 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[33, 08, 91, 22, 9F, C6, F7, 4C]] succeeded
DEBUG 2019-10-14 16:37:54,495 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:54,495 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xC3, 0xE1, 0xE6, 0xF6, 0xDD, 0x11, 0x86, 0xBB]
DEBUG 2019-10-14 16:37:54,496 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0xFB, 0xA4, 0xC0, 0x47, 0xBB, 0x02, 0x39, 0x1A, 0x0E, 0xCC, 0x43, 0x33, 0xBE, 0xCF, 0xFD, 0xD3, 0x21]
DEBUG 2019-10-14 16:37:54,497 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x9C, 0x72, 0x2D, 0x63]
DEBUG 2019-10-14 16:37:54,498 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:54,498 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0xC3, 0xE1, 0xE6, 0xF6, 0xDD, 0x11, 0x86, 0xBB, 0xFB, 0xA4, 0xC0, 0x47, 0xBB, 0x02, 0x39, 0x1A, 0x0E, 0xCC, 0x43, 0x33, 0xBE, 0xCF, 0xFD, 0xD3, 0x21, 0x9C, 0x72, 0x2D, 0x63] has been received.
DEBUG 2019-10-14 16:37:54,501 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0xC3, 0xE1, 0xE6, 0xF6, 0xDD, 0x11, 0x86, 0xBB, 0xFB, 0xA4, 0xC0, 0x47, 0xBB, 0x02, 0x39, 0x1A, 0x0E, 0xCC, 0x43, 0x33, 0xBE, 0xCF, 0xFD, 0xD3, 0x21, 0x9C, 0x72, 0x2D]]
DEBUG 2019-10-14 16:37:54,504 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x16, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:54,505 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_OPEN', Dec:'22', Hex: '0x16']].
DEBUG 2019-10-14 16:37:55,703 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:55,704 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:37:55,715 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:37:55,716 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:37:55,716 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:55,716 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:37:55,717 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[3F, 4A, DA, 24, 39, 4B, 80, BE]]
DEBUG 2019-10-14 16:37:55,718 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:55,718 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:37:55,719 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:37:55,720 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x26)' request (callback ID=0x26).
DEBUG 2019-10-14 16:37:55,721 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE, 0x05, 0x26, 0x3E].
DEBUG 2019-10-14 16:37:55,721 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:37:55,722 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:37:55,722 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:37:55,722 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:37:55,723 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:37:55,723 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:37:55,724 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:37:55,724 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:55,724 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x3F]
DEBUG 2019-10-14 16:37:55,725 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4A]
DEBUG 2019-10-14 16:37:55,725 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xDA]
DEBUG 2019-10-14 16:37:55,725 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x24]
DEBUG 2019-10-14 16:37:55,726 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x39]
DEBUG 2019-10-14 16:37:55,726 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4B]
DEBUG 2019-10-14 16:37:55,727 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:37:55,727 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xBE]
DEBUG 2019-10-14 16:37:55,727 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:37:55,728 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:37:55,728 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x3E]
DEBUG 2019-10-14 16:37:55,729 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:37:55,730 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE, 0x05, 0x26, 0x3E] transmission OK.
DEBUG 2019-10-14 16:37:55,731 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x26)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:37:55,734 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:55,735 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:37:55,735 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:55,736 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:37:55,736 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x26).
DEBUG 2019-10-14 16:37:55,736 (Z-Wave): RX_Session_Layer            : Waiting 64,983 [ms] for 'ZW_SendData' callback frame (callback ID=0x26).
DEBUG 2019-10-14 16:37:55,818 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:55,819 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x26, 0x00, 0x00, 0x08, 0xC5]
DEBUG 2019-10-14 16:37:55,820 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:55,820 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x26, 0x00, 0x00, 0x08, 0xC5] has been received.
DEBUG 2019-10-14 16:37:55,821 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x26, 0x00, 0x00, 0x08, 0xC5] (callback ID=0x26) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0x3F, 0x4A, 0xDA, 0x24, 0x39, 0x4B, 0x80, 0xBE], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x26)' successfully executed.
DEBUG 2019-10-14 16:37:55,822 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[3F, 4A, DA, 24, 39, 4B, 80, BE]] succeeded
DEBUG 2019-10-14 16:37:55,895 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:37:55,896 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x92, 0x37, 0x98, 0x33, 0x9C, 0xE3, 0x4A, 0x80, 0xF6, 0xDF, 0xFC]
DEBUG 2019-10-14 16:37:55,897 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x10, 0x37, 0x9A, 0x94, 0xE3, 0xCA, 0x3F, 0xBD, 0x3F, 0x8A, 0x05, 0x87, 0x7F, 0x16, 0xFB, 0xF4, 0xC3, 0x93]
DEBUG 2019-10-14 16:37:55,897 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:37:55,898 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x92, 0x37, 0x98, 0x33, 0x9C, 0xE3, 0x4A, 0x80, 0xF6, 0xDF, 0xFC, 0x10, 0x37, 0x9A, 0x94, 0xE3, 0xCA, 0x3F, 0xBD, 0x3F, 0x8A, 0x05, 0x87, 0x7F, 0x16, 0xFB, 0xF4, 0xC3, 0x93] has been received.
DEBUG 2019-10-14 16:37:55,900 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x92, 0x37, 0x98, 0x33, 0x9C, 0xE3, 0x4A, 0x80, 0xF6, 0xDF, 0xFC, 0x10, 0x37, 0x9A, 0x94, 0xE3, 0xCA, 0x3F, 0xBD, 0x3F, 0x8A, 0x05, 0x87, 0x7F, 0x16, 0xFB, 0xF4, 0xC3]]
DEBUG 2019-10-14 16:37:55,903 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x17, 0x00, 0x00]].
DEBUG 2019-10-14 16:37:55,905 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_CLOSE', Dec:'23', Hex: '0x17']].
DEBUG 2019-10-14 16:39:37,882 (Z-Wave): Node_Initializer            : Node '7' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:39:37,883 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=7)'.
DEBUG 2019-10-14 16:39:37,883 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=7)'.
DEBUG 2019-10-14 16:39:37,884 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=7)'...
DEBUG 2019-10-14 16:39:37,884 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=7)' call.
DEBUG 2019-10-14 16:39:37,884 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x07, 0x9C].
DEBUG 2019-10-14 16:39:37,885 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:37,886 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:39:37,886 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:37,887 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:39:37,887 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x07]
DEBUG 2019-10-14 16:39:37,887 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x9C]
DEBUG 2019-10-14 16:39:37,889 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:37,889 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x07, 0x9C] transmission OK.
DEBUG 2019-10-14 16:39:37,890 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=7)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:37,898 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:37,898 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:39:37,899 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:37,899 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:39:37,899 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=7)'.
DEBUG 2019-10-14 16:39:39,720 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:39:39,720 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '52', endPoint = '0'
DEBUG 2019-10-14 16:39:39,721 (Z-Wave): Command_Builder             : Z-Wave command: command = status
DEBUG 2019-10-14 16:39:39,721 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:39:39,721 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:39:39,721 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_GET]
DEBUG 2019-10-14 16:39:39,722 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:44,576 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:39:44,577 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '21', endPoint = '0'
DEBUG 2019-10-14 16:39:44,577 (Z-Wave): Command_Builder             : Z-Wave command: command = status
DEBUG 2019-10-14 16:39:44,577 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:39:44,577 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:39:44,577 (Z-Wave): CCSwitchBinary              : Node '21:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET]
DEBUG 2019-10-14 16:39:44,578 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=2) Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:44,659 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:44,659 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:39:44,660 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:44,660 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:39:44,660 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=7)' successfully executed.
DEBUG 2019-10-14 16:39:44,661 (Z-Wave): Node_Initializer            : Node '7' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:39:44,662 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:44,662 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:39:44,662 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x27)' request (callback ID=0x27).
DEBUG 2019-10-14 16:39:44,663 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x34, 0x02, 0x26, 0x02, 0x05, 0x27, 0xD5].
DEBUG 2019-10-14 16:39:44,663 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:44,664 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:44,664 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:44,664 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:39:44,665 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x34]
DEBUG 2019-10-14 16:39:44,665 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,665 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:39:44,665 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,666 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:39:44,666 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x27]
DEBUG 2019-10-14 16:39:44,666 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xD5]
DEBUG 2019-10-14 16:39:44,666 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:44,667 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x34, 0x02, 0x26, 0x02, 0x05, 0x27, 0xD5] transmission OK.
DEBUG 2019-10-14 16:39:44,667 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x27)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:44,673 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:44,673 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:39:44,678 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:44,678 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:39:44,678 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x27).
DEBUG 2019-10-14 16:39:44,679 (Z-Wave): RX_Session_Layer            : Waiting 64,984 [ms] for 'ZW_SendData' callback frame (callback ID=0x27).
DEBUG 2019-10-14 16:39:44,693 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:44,694 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x27, 0x00, 0x00, 0x02, 0xCE]
DEBUG 2019-10-14 16:39:44,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:44,694 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x27, 0x00, 0x00, 0x02, 0xCE] has been received.
DEBUG 2019-10-14 16:39:44,695 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x27, 0x00, 0x00, 0x02, 0xCE] (callback ID=0x27) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x27)' successfully executed.
DEBUG 2019-10-14 16:39:44,696 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_GET] succeeded.
DEBUG 2019-10-14 16:39:44,696 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:44,696 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:39:44,697 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x28)' request (callback ID=0x28).
DEBUG 2019-10-14 16:39:44,697 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x28, 0xF8].
DEBUG 2019-10-14 16:39:44,698 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:44,698 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:44,698 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:44,699 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:39:44,699 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x15]
DEBUG 2019-10-14 16:39:44,699 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,699 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:39:44,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:39:44,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x28]
DEBUG 2019-10-14 16:39:44,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xF8]
DEBUG 2019-10-14 16:39:44,706 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:44,706 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x09, 0x00, 0x04, 0x00, 0x34, 0x03, 0x26, 0x03, 0x00, 0xE0]
DEBUG 2019-10-14 16:39:44,707 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:44,707 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x09, 0x00, 0x04, 0x00, 0x34, 0x03, 0x26, 0x03, 0x00, 0xE0] has been received.
DEBUG 2019-10-14 16:39:44,707 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x18]
DEBUG 2019-10-14 16:39:44,707 (Z-Wave): RX_Session_Layer            : Received an unexpected frame [APP_CMD_HANDLER_FRAME : NodeID='52', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SWITCH_MULTILEVEL', Command='0x03', Parameters: [0x00]] while waiting for an ACK of the Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x28)'.
DEBUG 2019-10-14 16:39:44,708 (Z-Wave): RX_Frame_Layer              : CAN -> Failed to send data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x28, 0xF8] because the Z-Wave firmware has an ACK expected instead of the sent frame
DEBUG 2019-10-14 16:39:44,708 (Z-Wave): TX_Frame_Layer              : CAN -> Wait 100 [ms] before next retransmission attempt.
DEBUG 2019-10-14 16:39:44,708 (Z-Wave): RX_Session_Layer            : Node '52' : [APP_CMD_HANDLER_FRAME : NodeID='52', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SWITCH_MULTILEVEL', Command='0x03', Parameters: [0x00]]
DEBUG 2019-10-14 16:39:44,709 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_REPORT, Value='0'].
DEBUG 2019-10-14 16:39:44,809 (Z-Wave): TX_Frame_Layer              : Retransmission attempt 1, data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x28, 0xF8]
DEBUG 2019-10-14 16:39:44,809 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:44,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:44,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:44,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:39:44,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x15]
DEBUG 2019-10-14 16:39:44,811 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,811 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:39:44,811 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:44,811 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:39:44,812 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x28]
DEBUG 2019-10-14 16:39:44,812 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xF8]
DEBUG 2019-10-14 16:39:44,812 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:44,813 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x28, 0xF8] transmission OK.
DEBUG 2019-10-14 16:39:44,813 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x28)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:44,821 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:44,822 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:39:44,822 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:44,822 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:39:44,823 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x28).
DEBUG 2019-10-14 16:39:44,823 (Z-Wave): RX_Session_Layer            : Waiting 64,874 [ms] for 'ZW_SendData' callback frame (callback ID=0x28).
DEBUG 2019-10-14 16:39:47,781 (Z-Wave): Node_Initializer            : Node '9' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:39:47,782 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=9)'.
DEBUG 2019-10-14 16:39:47,850 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:47,851 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x28, 0x01, 0x01, 0x30, 0xF3]
DEBUG 2019-10-14 16:39:47,852 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:47,852 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x28, 0x01, 0x01, 0x30, 0xF3] has been received.
DEBUG 2019-10-14 16:39:47,854 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x28, 0x01, 0x01, 0x30, 0xF3] (callback ID=0x28) with state 'TRANSMIT_COMPLETE_NO_ACK' received -> Failed to execute Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x28)'
DEBUG 2019-10-14 16:39:47,854 (Z-Wave): CCSwitchBinary              : Node '21:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET] failed : 'NO_ACK_ERROR'.
DEBUG 2019-10-14 16:39:47,855 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=9)'.
DEBUG 2019-10-14 16:39:47,856 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=9)'...
DEBUG 2019-10-14 16:39:47,856 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=9)' call.
DEBUG 2019-10-14 16:39:47,856 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x09, 0x92].
DEBUG 2019-10-14 16:39:47,857 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:47,858 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:39:47,858 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:47,858 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:39:47,859 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:47,859 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x92]
DEBUG 2019-10-14 16:39:47,860 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:47,861 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x09, 0x92] transmission OK.
DEBUG 2019-10-14 16:39:47,861 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=9)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:47,869 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:47,870 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:39:47,871 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:47,871 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:39:47,872 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=9)'.
DEBUG 2019-10-14 16:39:49,613 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:39:49,613 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '9', endPoint = '0'
DEBUG 2019-10-14 16:39:49,614 (Z-Wave): Command_Builder             : Z-Wave command: command = STATUS
DEBUG 2019-10-14 16:39:49,614 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:39:49,614 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:39:49,614 (Z-Wave): CCSwitchBinary              : Node '9:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET]
DEBUG 2019-10-14 16:39:49,615 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:54,664 (Z-Wave): Node_Initializer            : Node '21' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:39:54,665 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=2) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=21)'.
DEBUG 2019-10-14 16:39:54,681 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:54,682 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:39:54,682 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:54,683 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:39:54,684 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=9)' successfully executed.
DEBUG 2019-10-14 16:39:54,685 (Z-Wave): Node_Initializer            : Node '9' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:39:54,686 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:39:54,687 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:39:54,688 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x29)' request (callback ID=0x29).
DEBUG 2019-10-14 16:39:54,689 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x09, 0x02, 0x25, 0x02, 0x05, 0x29, 0xE5].
DEBUG 2019-10-14 16:39:54,689 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:54,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:54,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:54,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:39:54,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:39:54,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:54,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:39:54,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:39:54,693 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:39:54,693 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x29]
DEBUG 2019-10-14 16:39:54,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xE5]
DEBUG 2019-10-14 16:39:54,694 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:54,695 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x09, 0x02, 0x25, 0x02, 0x05, 0x29, 0xE5] transmission OK.
DEBUG 2019-10-14 16:39:54,696 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x29)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:54,704 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:54,705 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:39:54,705 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:54,705 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:39:54,706 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x29).
DEBUG 2019-10-14 16:39:54,707 (Z-Wave): RX_Session_Layer            : Waiting 64,981 [ms] for 'ZW_SendData' callback frame (callback ID=0x29).
DEBUG 2019-10-14 16:39:57,437 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:57,438 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x29, 0x01, 0x01, 0x12, 0xD0]
DEBUG 2019-10-14 16:39:57,440 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x29, 0x01, 0x01, 0x12, 0xD0] has been received.
DEBUG 2019-10-14 16:39:57,440 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:57,441 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x29, 0x01, 0x01, 0x12, 0xD0] (callback ID=0x29) with state 'TRANSMIT_COMPLETE_NO_ACK' received -> Failed to execute Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x29)'
DEBUG 2019-10-14 16:39:57,441 (Z-Wave): CCSwitchBinary              : Node '9:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET] failed : 'NO_ACK_ERROR'.
DEBUG 2019-10-14 16:39:57,442 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=21)'.
DEBUG 2019-10-14 16:39:57,443 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=21)'...
DEBUG 2019-10-14 16:39:57,443 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=21)' call.
DEBUG 2019-10-14 16:39:57,444 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x15, 0x8E].
DEBUG 2019-10-14 16:39:57,445 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:39:57,445 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:39:57,446 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:39:57,446 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:39:57,446 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x15]
DEBUG 2019-10-14 16:39:57,447 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x8E]
DEBUG 2019-10-14 16:39:57,447 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:39:57,448 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x15, 0x8E] transmission OK.
DEBUG 2019-10-14 16:39:57,448 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=21)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:39:57,458 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:39:57,458 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:39:57,459 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:39:57,459 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:39:57,460 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=21)'.
DEBUG 2019-10-14 16:40:00,060 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:40:00,060 (Z-Wave): Command_Builder             : Z-Wave command: command = OFF
DEBUG 2019-10-14 16:40:00,061 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '52', endPoint = '0'
DEBUG 2019-10-14 16:40:00,061 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:40:00,062 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:40:00,062 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_SET, Value='0']
DEBUG 2019-10-14 16:40:00,063 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:40:04,455 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:04,456 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:40:04,457 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:40:04,457 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:04,458 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=21)' successfully executed.
DEBUG 2019-10-14 16:40:04,460 (Z-Wave): Node_Initializer            : Node '21' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:40:04,461 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:40:04,462 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:40:04,463 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2A)' request (callback ID=0x2A).
DEBUG 2019-10-14 16:40:04,464 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x0A, 0x00, 0x13, 0x34, 0x03, 0x26, 0x01, 0x00, 0x05, 0x2A, 0xD9].
DEBUG 2019-10-14 16:40:04,465 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:04,466 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:40:04,466 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:04,467 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:40:04,467 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x34]
DEBUG 2019-10-14 16:40:04,468 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x03]
DEBUG 2019-10-14 16:40:04,468 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:40:04,468 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:04,469 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:04,470 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:40:04,471 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2A]
DEBUG 2019-10-14 16:40:04,471 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xD9]
DEBUG 2019-10-14 16:40:04,471 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:40:04,472 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x0A, 0x00, 0x13, 0x34, 0x03, 0x26, 0x01, 0x00, 0x05, 0x2A, 0xD9] transmission OK.
DEBUG 2019-10-14 16:40:04,473 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2A)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:40:04,478 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:04,479 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:40:04,479 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:40:04,480 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:04,480 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2A).
DEBUG 2019-10-14 16:40:04,480 (Z-Wave): RX_Session_Layer            : Waiting 64,982 [ms] for 'ZW_SendData' callback frame (callback ID=0x2A).
DEBUG 2019-10-14 16:40:04,498 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:04,499 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2A, 0x00, 0x00, 0x03, 0xC2]
DEBUG 2019-10-14 16:40:04,500 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:04,500 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2A, 0x00, 0x00, 0x03, 0xC2] has been received.
DEBUG 2019-10-14 16:40:04,502 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2A, 0x00, 0x00, 0x03, 0xC2] (callback ID=0x2A) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x01, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2A)' successfully executed.
DEBUG 2019-10-14 16:40:04,503 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_SET, Value='0'] succeeded
DEBUG 2019-10-14 16:40:08,567 (Z-Wave): Node_Initializer            : Node '22' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:40:08,568 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=22)'.
DEBUG 2019-10-14 16:40:08,569 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=22)'.
DEBUG 2019-10-14 16:40:08,569 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=22)'...
DEBUG 2019-10-14 16:40:08,570 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=22)' call.
DEBUG 2019-10-14 16:40:08,570 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x16, 0x8D].
DEBUG 2019-10-14 16:40:08,572 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:08,573 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:40:08,573 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:08,574 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:40:08,575 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x16]
DEBUG 2019-10-14 16:40:08,576 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x8D]
DEBUG 2019-10-14 16:40:08,577 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:40:08,578 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x16, 0x8D] transmission OK.
DEBUG 2019-10-14 16:40:08,579 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=22)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:40:08,586 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:08,587 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:40:08,587 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:40:08,588 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:08,588 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=22)'.
DEBUG 2019-10-14 16:40:16,837 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:16,838 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:40:16,839 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:40:16,839 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:16,839 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=22)' successfully executed.
DEBUG 2019-10-14 16:40:16,841 (Z-Wave): Node_Initializer            : Node '22' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:40:25,056 (Z-Wave): Node_Initializer            : Node '23' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:40:25,057 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=23)'.
DEBUG 2019-10-14 16:40:25,057 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=23)'.
DEBUG 2019-10-14 16:40:25,057 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=23)'...
DEBUG 2019-10-14 16:40:25,058 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=23)' call.
DEBUG 2019-10-14 16:40:25,058 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x17, 0x8C].
DEBUG 2019-10-14 16:40:25,060 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:25,061 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:40:25,062 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:25,062 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:40:25,063 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x17]
DEBUG 2019-10-14 16:40:25,064 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x8C]
DEBUG 2019-10-14 16:40:25,067 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:40:25,067 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x17, 0x8C] transmission OK.
DEBUG 2019-10-14 16:40:25,068 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=23)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:40:25,075 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:25,075 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:40:25,076 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:40:25,076 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=23)'.
DEBUG 2019-10-14 16:40:25,077 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:34,655 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:34,656 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:40:34,657 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:40:34,658 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=23)' successfully executed.
DEBUG 2019-10-14 16:40:34,659 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:34,661 (Z-Wave): Node_Initializer            : Node '23' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:40:34,697 (Z-Wave): Node_Initializer            : Node '24' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:40:34,697 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=24)'.
DEBUG 2019-10-14 16:40:34,698 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=24)'.
DEBUG 2019-10-14 16:40:34,698 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=24)'...
DEBUG 2019-10-14 16:40:34,698 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=24)' call.
DEBUG 2019-10-14 16:40:34,699 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x18, 0x83].
DEBUG 2019-10-14 16:40:34,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:34,700 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:40:34,701 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:34,701 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:40:34,701 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x18]
DEBUG 2019-10-14 16:40:34,702 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x83]
DEBUG 2019-10-14 16:40:34,703 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:40:34,703 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x18, 0x83] transmission OK.
DEBUG 2019-10-14 16:40:34,704 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=24)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:40:34,711 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:34,712 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:40:34,713 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:40:34,714 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=24)'.
DEBUG 2019-10-14 16:40:34,714 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:42,046 (Z-Wave): Node_Initializer            : Node '26' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:40:42,047 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=26)'.
DEBUG 2019-10-14 16:40:42,147 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:42,148 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:40:42,148 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:40:42,149 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:42,149 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=24)' successfully executed.
DEBUG 2019-10-14 16:40:42,151 (Z-Wave): Node_Initializer            : Node '24' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:40:42,151 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=26)'.
DEBUG 2019-10-14 16:40:42,152 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=26)'...
DEBUG 2019-10-14 16:40:42,152 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=26)' call.
DEBUG 2019-10-14 16:40:42,153 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x1A, 0x81].
DEBUG 2019-10-14 16:40:42,154 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:40:42,154 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:40:42,155 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:40:42,156 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:40:42,156 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x1A]
DEBUG 2019-10-14 16:40:42,157 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x81]
DEBUG 2019-10-14 16:40:42,158 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:40:42,159 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x1A, 0x81] transmission OK.
DEBUG 2019-10-14 16:40:42,159 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=26)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:40:42,167 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:42,168 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:40:42,168 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:40:42,168 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:42,169 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=26)'.
DEBUG 2019-10-14 16:40:50,024 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:40:50,025 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:40:50,026 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:40:50,026 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:40:50,026 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=26)' successfully executed.
DEBUG 2019-10-14 16:40:50,029 (Z-Wave): Node_Initializer            : Node '26' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:41:01,841 (Z-Wave): Node_Initializer            : Node '38' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:41:01,842 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=38)'.
DEBUG 2019-10-14 16:41:01,842 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=38)'.
DEBUG 2019-10-14 16:41:01,842 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=38)'...
DEBUG 2019-10-14 16:41:01,843 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=38)' call.
DEBUG 2019-10-14 16:41:01,843 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x26, 0xBD].
DEBUG 2019-10-14 16:41:01,845 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:41:01,846 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:41:01,846 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:41:01,847 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:41:01,848 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:41:01,849 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xBD]
DEBUG 2019-10-14 16:41:01,850 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:41:01,850 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x26, 0xBD] transmission OK.
DEBUG 2019-10-14 16:41:01,851 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=38)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:41:01,859 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:01,860 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:41:01,860 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:41:01,861 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:01,861 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=38)'.
DEBUG 2019-10-14 16:41:10,177 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:10,179 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:41:10,180 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:41:10,180 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:10,181 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=38)' successfully executed.
DEBUG 2019-10-14 16:41:10,183 (Z-Wave): Node_Initializer            : Node '38' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:41:16,801 (Z-Wave): Node_Initializer            : Node '40' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:41:16,802 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=40)'.
DEBUG 2019-10-14 16:41:16,802 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=40)'.
DEBUG 2019-10-14 16:41:16,802 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=40)'...
DEBUG 2019-10-14 16:41:16,802 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=40)' call.
DEBUG 2019-10-14 16:41:16,803 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x28, 0xB3].
DEBUG 2019-10-14 16:41:16,804 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:41:16,804 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:41:16,805 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:41:16,805 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:41:16,805 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x28]
DEBUG 2019-10-14 16:41:16,806 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB3]
DEBUG 2019-10-14 16:41:16,807 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:41:16,808 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x28, 0xB3] transmission OK.
DEBUG 2019-10-14 16:41:16,808 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=40)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:41:16,816 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:16,817 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:41:16,818 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:41:16,818 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:16,818 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=40)'.
DEBUG 2019-10-14 16:41:24,539 (Z-Wave): Node_Initializer            : Node '41' : [ZW_RequestNodeInfo, (Retry='8')]
DEBUG 2019-10-14 16:41:24,541 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=41)'.
DEBUG 2019-10-14 16:41:25,917 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:25,919 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00]
DEBUG 2019-10-14 16:41:25,929 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x00, 0x31]
DEBUG 2019-10-14 16:41:25,930 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:25,931 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:41:25,932 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=40)' successfully executed.
DEBUG 2019-10-14 16:41:25,934 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=41)'.
DEBUG 2019-10-14 16:41:25,934 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=41)'...
DEBUG 2019-10-14 16:41:25,935 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=41)' call.
DEBUG 2019-10-14 16:41:25,935 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x29, 0xB2].
DEBUG 2019-10-14 16:41:25,936 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:41:25,936 (Z-Wave): Node_Initializer            : Node '40' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:41:25,937 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:41:25,938 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:41:25,938 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:41:25,939 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x29]
DEBUG 2019-10-14 16:41:25,939 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB2]
DEBUG 2019-10-14 16:41:25,941 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:41:25,942 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x29, 0xB2] transmission OK.
DEBUG 2019-10-14 16:41:25,943 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=41)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:41:25,950 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:25,951 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:41:25,952 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:25,952 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:41:25,953 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=41)'.
DEBUG 2019-10-14 16:41:33,614 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:41:33,615 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31]
DEBUG 2019-10-14 16:41:33,616 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:41:33,616 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] has been received.
DEBUG 2019-10-14 16:41:33,617 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x06, 0x00, 0x49, 0x81, 0x00, 0x00, 0x31] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=41)' successfully executed.
DEBUG 2019-10-14 16:41:33,619 (Z-Wave): Node_Initializer            : Node '41' : [ZW_RequestNodeInfo, (Retry='8')] failed : 'REQUEST_NODE_INFO_NODE_ACK_ERROR'.
DEBUG 2019-10-14 16:42:29,682 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:42:29,682 (Z-Wave): Command_Builder             : Z-Wave command: command = status
DEBUG 2019-10-14 16:42:29,682 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '52', endPoint = '0'
DEBUG 2019-10-14 16:42:29,683 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:42:29,683 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:42:29,684 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_GET]
DEBUG 2019-10-14 16:42:29,685 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:42:29,685 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:42:29,686 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:42:29,687 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2B)' request (callback ID=0x2B).
DEBUG 2019-10-14 16:42:29,688 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x34, 0x02, 0x26, 0x02, 0x05, 0x2B, 0xD9].
DEBUG 2019-10-14 16:42:29,689 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:42:29,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:42:29,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:42:29,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:42:29,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x34]
DEBUG 2019-10-14 16:42:29,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:29,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x26]
DEBUG 2019-10-14 16:42:29,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:29,693 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:42:29,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2B]
DEBUG 2019-10-14 16:42:29,695 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xD9]
DEBUG 2019-10-14 16:42:29,696 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:42:29,699 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x34, 0x02, 0x26, 0x02, 0x05, 0x2B, 0xD9] transmission OK.
DEBUG 2019-10-14 16:42:29,701 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2B)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:42:29,701 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:29,704 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:42:29,705 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:42:29,705 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2B).
DEBUG 2019-10-14 16:42:29,706 (Z-Wave): RX_Session_Layer            : Waiting 64,981 [ms] for 'ZW_SendData' callback frame (callback ID=0x2B).
DEBUG 2019-10-14 16:42:29,707 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:29,721 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:29,722 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2B, 0x00, 0x00, 0x03, 0xC3]
DEBUG 2019-10-14 16:42:29,723 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:29,724 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2B, 0x00, 0x00, 0x03, 0xC3] has been received.
DEBUG 2019-10-14 16:42:29,725 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2B, 0x00, 0x00, 0x03, 0xC3] (callback ID=0x2B) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=52, Payload=[0x26, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2B)' successfully executed.
DEBUG 2019-10-14 16:42:29,726 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_GET] succeeded.
DEBUG 2019-10-14 16:42:29,735 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:29,736 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x09, 0x00, 0x04, 0x00, 0x34, 0x03, 0x26, 0x03, 0x00, 0xE0]
DEBUG 2019-10-14 16:42:29,737 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:29,737 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x09, 0x00, 0x04, 0x00, 0x34, 0x03, 0x26, 0x03, 0x00, 0xE0] has been received.
DEBUG 2019-10-14 16:42:29,738 (Z-Wave): RX_Session_Layer            : Node '52' : [APP_CMD_HANDLER_FRAME : NodeID='52', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SWITCH_MULTILEVEL', Command='0x03', Parameters: [0x00]]
DEBUG 2019-10-14 16:42:29,739 (Z-Wave): CCMultiLevelSwitch          : Node '52:0' : [COMMAND_CLASS_SWITCH_MULTILEVEL::SWITCH_MULTILEVEL_REPORT, Value='0'].
DEBUG 2019-10-14 16:42:39,596 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:42:39,597 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '21', endPoint = '0'
DEBUG 2019-10-14 16:42:39,598 (Z-Wave): Command_Builder             : Z-Wave command: command = status
DEBUG 2019-10-14 16:42:39,598 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:42:39,598 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:42:39,599 (Z-Wave): CCSwitchBinary              : Node '21:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET]
DEBUG 2019-10-14 16:42:39,600 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:42:39,601 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:42:39,603 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2C)' request (callback ID=0x2C).
DEBUG 2019-10-14 16:42:39,604 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2C)'.
DEBUG 2019-10-14 16:42:39,604 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x2C, 0xFC].
DEBUG 2019-10-14 16:42:39,607 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:42:39,609 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:42:39,610 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:42:39,611 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:42:39,613 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x15]
DEBUG 2019-10-14 16:42:39,614 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:39,616 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:42:39,617 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:39,618 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:42:39,618 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2C]
DEBUG 2019-10-14 16:42:39,619 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xFC]
DEBUG 2019-10-14 16:42:39,621 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:42:39,622 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x15, 0x02, 0x25, 0x02, 0x05, 0x2C, 0xFC] transmission OK.
DEBUG 2019-10-14 16:42:39,622 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2C)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:42:39,628 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:39,629 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:42:39,630 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:42:39,630 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:39,630 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2C).
DEBUG 2019-10-14 16:42:39,631 (Z-Wave): RX_Session_Layer            : Waiting 64,972 [ms] for 'ZW_SendData' callback frame (callback ID=0x2C).
DEBUG 2019-10-14 16:42:42,505 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:42,506 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2C, 0x01, 0x01, 0x20, 0xE7]
DEBUG 2019-10-14 16:42:42,506 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:42,507 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2C, 0x01, 0x01, 0x20, 0xE7] has been received.
DEBUG 2019-10-14 16:42:42,508 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2C, 0x01, 0x01, 0x20, 0xE7] (callback ID=0x2C) with state 'TRANSMIT_COMPLETE_NO_ACK' received -> Failed to execute Z-Wave function 'ZW_SendData(NodeID=21, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2C)'
DEBUG 2019-10-14 16:42:42,508 (Z-Wave): CCSwitchBinary              : Node '21:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET] failed : 'NO_ACK_ERROR'.
DEBUG 2019-10-14 16:42:49,621 (Z-Wave): Command_Builder             : Building Z-Wave command
DEBUG 2019-10-14 16:42:49,624 (Z-Wave): Command_Builder             : Z-Wave command: command = STATUS
DEBUG 2019-10-14 16:42:49,625 (Z-Wave): Command_Builder             : Z-Wave command: nodeId = '9', endPoint = '0'
DEBUG 2019-10-14 16:42:49,626 (Z-Wave): Command_Builder             : Z-Wave command: paramValue = null
DEBUG 2019-10-14 16:42:49,626 (Z-Wave): Command_Builder             : Z-Wave command created successfully
DEBUG 2019-10-14 16:42:49,626 (Z-Wave): CCSwitchBinary              : Node '9:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET]
DEBUG 2019-10-14 16:42:49,628 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:42:49,628 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:42:49,629 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2D)'.
DEBUG 2019-10-14 16:42:49,629 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2D)' request (callback ID=0x2D).
DEBUG 2019-10-14 16:42:49,631 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x09, 0x02, 0x25, 0x02, 0x05, 0x2D, 0xE1].
DEBUG 2019-10-14 16:42:49,632 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:42:49,633 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:42:49,635 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:42:49,636 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:42:49,638 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:42:49,639 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:49,640 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x25]
DEBUG 2019-10-14 16:42:49,640 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:42:49,641 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:42:49,642 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2D]
DEBUG 2019-10-14 16:42:49,642 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xE1]
DEBUG 2019-10-14 16:42:49,643 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:42:49,644 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x09, 0x02, 0x25, 0x02, 0x05, 0x2D, 0xE1] transmission OK.
DEBUG 2019-10-14 16:42:49,645 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2D)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:42:49,652 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:49,653 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:42:49,654 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:42:49,654 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:49,654 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2D).
DEBUG 2019-10-14 16:42:49,655 (Z-Wave): RX_Session_Layer            : Waiting 64,974 [ms] for 'ZW_SendData' callback frame (callback ID=0x2D).
DEBUG 2019-10-14 16:42:52,517 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:42:52,519 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2D, 0x01, 0x01, 0x1F, 0xD9]
DEBUG 2019-10-14 16:42:52,519 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:42:52,519 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2D, 0x01, 0x01, 0x1F, 0xD9] has been received.
DEBUG 2019-10-14 16:42:52,521 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2D, 0x01, 0x01, 0x1F, 0xD9] (callback ID=0x2D) with state 'TRANSMIT_COMPLETE_NO_ACK' received -> Failed to execute Z-Wave function 'ZW_SendData(NodeID=9, Payload=[0x25, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2D)'
DEBUG 2019-10-14 16:42:52,521 (Z-Wave): CCSwitchBinary              : Node '9:0' : [COMMAND_CLASS_SWITCH_BINARY::SWITCH_BINARY_GET] failed : 'NO_ACK_ERROR'.
DEBUG 2019-10-14 16:43:05,103 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,104 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x31, 0x02, 0x84, 0x07, 0x43]
DEBUG 2019-10-14 16:43:05,105 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,105 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x31, 0x02, 0x84, 0x07, 0x43] has been received.
DEBUG 2019-10-14 16:43:05,106 (Z-Wave): RX_Session_Layer            : Node '49' : [APP_CMD_HANDLER_FRAME : NodeID='49', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_WAKE_UP', Command='0x07', Parameters: [ - ]]
DEBUG 2019-10-14 16:43:05,108 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=49)'.
DEBUG 2019-10-14 16:43:05,108 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=49)'.
DEBUG 2019-10-14 16:43:05,108 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=49)'...
DEBUG 2019-10-14 16:43:05,109 (Z-Wave): ZW_RequestNodeInfo          : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=49)' call.
DEBUG 2019-10-14 16:43:05,109 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x04, 0x00, 0x60, 0x31, 0xAA].
DEBUG 2019-10-14 16:43:05,110 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:05,111 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:43:05,112 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:05,112 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x60]
DEBUG 2019-10-14 16:43:05,113 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:05,114 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xAA]
DEBUG 2019-10-14 16:43:05,116 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:05,117 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x31, 0xAA] transmission OK.
DEBUG 2019-10-14 16:43:05,117 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=49)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:05,120 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,121 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B]
DEBUG 2019-10-14 16:43:05,122 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received.
DEBUG 2019-10-14 16:43:05,122 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,123 (Z-Wave): RX_Session_Layer            : Response received [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] -> Waiting 65,000 [ms] for callback of Z-Wave function call 'ZW_RequestNodeInfo(NodeID=49)'.
DEBUG 2019-10-14 16:43:05,232 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,233 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x15, 0x00, 0x49, 0x84, 0x31, 0x0F, 0x04, 0x07, 0x01, 0x5E, 0x72, 0x5A, 0x80, 0x73, 0x86, 0x84]
DEBUG 2019-10-14 16:43:05,237 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x85, 0x59, 0x71, 0x70, 0x7A, 0x3B]
DEBUG 2019-10-14 16:43:05,238 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,239 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x15, 0x00, 0x49, 0x84, 0x31, 0x0F, 0x04, 0x07, 0x01, 0x5E, 0x72, 0x5A, 0x80, 0x73, 0x86, 0x84, 0x85, 0x59, 0x71, 0x70, 0x7A, 0x3B] has been received.
DEBUG 2019-10-14 16:43:05,240 (Z-Wave): RX_Session_Layer            : Callback received [0x01, 0x15, 0x00, 0x49, 0x84, 0x31, 0x0F, 0x04, 0x07, 0x01, 0x5E, 0x72, 0x5A, 0x80, 0x73, 0x86, 0x84, 0x85, 0x59, 0x71, 0x70, 0x7A, 0x3B] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=49)' successfully executed.
DEBUG 2019-10-14 16:43:05,243 (Z-Wave): Node_Initializer            : Node '49' : [ZW_RequestNodeInfo, (Retry='1')] succeeded : [[Status: UPDATE_STATE_NODE_INFO_RECEIVED, Node ID: 49, Device Classes: [Basic: BASIC_TYPE_ROUTING_SLAVE, Generic: GENERIC_TYPE_SENSOR_NOTIFICATION, Specific: SPECIFIC_TYPE_NOTIFICATION_SENSOR], Command Classes: [Supported: [COMMAND_CLASS_ZWAVEPLUS_INFO, COMMAND_CLASS_MANUFACTURER_SPECIFIC, COMMAND_CLASS_DEVICE_RESET_LOCALLY, COMMAND_CLASS_BATTERY, COMMAND_CLASS_POWERLEVEL, COMMAND_CLASS_VERSION, COMMAND_CLASS_WAKE_UP, COMMAND_CLASS_ASSOCIATION, COMMAND_CLASS_ASSOCIATION_GRP_INFO, COMMAND_CLASS_ALARM, COMMAND_CLASS_CONFIGURATION, COMMAND_CLASS_FIRMWARE_UPDATE_MD], Controlled: [ -- ]]]].
DEBUG 2019-10-14 16:43:05,243 (Z-Wave): Node_Initializer            : Node '49' : ====== Update dynamic data of command classes...
DEBUG 2019-10-14 16:43:05,244 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_BATTERY]
DEBUG 2019-10-14 16:43:05,244 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_BATTERY::BATTERY_GET (Retry='1')]
DEBUG 2019-10-14 16:43:05,245 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:05,245 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:05,248 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:05,249 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2E)' request (callback ID=0x2E).
DEBUG 2019-10-14 16:43:05,250 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x31, 0x02, 0x80, 0x02, 0x05, 0x2E, 0x7F].
DEBUG 2019-10-14 16:43:05,251 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:05,251 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:43:05,251 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:05,252 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:05,252 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:05,253 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:43:05,253 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:43:05,253 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:43:05,254 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:05,254 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2E]
DEBUG 2019-10-14 16:43:05,255 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x7F]
DEBUG 2019-10-14 16:43:05,255 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:05,256 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x31, 0x02, 0x80, 0x02, 0x05, 0x2E, 0x7F] transmission OK.
DEBUG 2019-10-14 16:43:05,257 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2E)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:05,261 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,261 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:05,262 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:05,262 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,263 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2E).
DEBUG 2019-10-14 16:43:05,263 (Z-Wave): RX_Session_Layer            : Waiting 64,986 [ms] for 'ZW_SendData' callback frame (callback ID=0x2E).
DEBUG 2019-10-14 16:43:05,355 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,355 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2E, 0x00, 0x00, 0x0A, 0xCF]
DEBUG 2019-10-14 16:43:05,356 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2E, 0x00, 0x00, 0x0A, 0xCF] has been received.
DEBUG 2019-10-14 16:43:05,356 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,357 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2E, 0x00, 0x00, 0x0A, 0xCF] (callback ID=0x2E) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2E)' successfully executed.
DEBUG 2019-10-14 16:43:05,359 (Z-Wave): RX_Session_Layer            : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2E)
DEBUG 2019-10-14 16:43:05,397 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,398 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x09, 0x00, 0x04, 0x00, 0x31, 0x03, 0x80, 0x03, 0x64, 0x27]
DEBUG 2019-10-14 16:43:05,399 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,400 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x09, 0x00, 0x04, 0x00, 0x31, 0x03, 0x80, 0x03, 0x64, 0x27] has been received.
DEBUG 2019-10-14 16:43:05,400 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_BATTERY::BATTERY_REPORT (Retry='1'), BatteryLevel='100']
DEBUG 2019-10-14 16:43:05,402 (Z-Wave): RX_Session_Layer            : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=49, Payload=[0x80, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2E)
DEBUG 2019-10-14 16:43:05,403 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_CONFIGURATION]
DEBUG 2019-10-14 16:43:05,403 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_BASIC]
DEBUG 2019-10-14 16:43:05,404 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_BASIC::BASIC_GET (Retry='1')]
DEBUG 2019-10-14 16:43:05,405 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:05,405 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:05,405 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:05,406 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2F)' request (callback ID=0x2F).
DEBUG 2019-10-14 16:43:05,407 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x09, 0x00, 0x13, 0x31, 0x02, 0x20, 0x02, 0x05, 0x2F, 0xDE].
DEBUG 2019-10-14 16:43:05,408 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:05,408 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x09]
DEBUG 2019-10-14 16:43:05,409 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:05,409 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:05,410 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:05,410 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:43:05,411 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x20]
DEBUG 2019-10-14 16:43:05,411 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x02]
DEBUG 2019-10-14 16:43:05,412 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:05,412 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x2F]
DEBUG 2019-10-14 16:43:05,413 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xDE]
DEBUG 2019-10-14 16:43:05,413 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:05,414 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x31, 0x02, 0x20, 0x02, 0x05, 0x2F, 0xDE] transmission OK.
DEBUG 2019-10-14 16:43:05,415 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2F)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:05,419 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,419 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:05,420 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,421 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:05,422 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x2F).
DEBUG 2019-10-14 16:43:05,422 (Z-Wave): RX_Session_Layer            : Waiting 64,984 [ms] for 'ZW_SendData' callback frame (callback ID=0x2F).
DEBUG 2019-10-14 16:43:05,500 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,503 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x15, 0x00, 0x49, 0x84, 0x31, 0x0F, 0x04, 0x07, 0x01, 0x5E, 0x72, 0x5A, 0x80, 0x73, 0x86, 0x84, 0x85, 0x59, 0x71, 0x70, 0x7A, 0x3B]
DEBUG 2019-10-14 16:43:05,505 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x15, 0x00, 0x49, 0x84, 0x31, 0x0F, 0x04, 0x07, 0x01, 0x5E, 0x72, 0x5A, 0x80, 0x73, 0x86, 0x84, 0x85, 0x59, 0x71, 0x70, 0x7A, 0x3B] has been received.
DEBUG 2019-10-14 16:43:05,509 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,561 (Z-Wave): RX_Session_Layer            : 'Application Controller Update' frame [Status: UPDATE_STATE_NODE_INFO_RECEIVED, Node ID: 49, Device Classes: [Basic: BASIC_TYPE_ROUTING_SLAVE, Generic: GENERIC_TYPE_SENSOR_NOTIFICATION, Specific: SPECIFIC_TYPE_NOTIFICATION_SENSOR], Command Classes: [Supported: [COMMAND_CLASS_ZWAVEPLUS_INFO, COMMAND_CLASS_MANUFACTURER_SPECIFIC, COMMAND_CLASS_DEVICE_RESET_LOCALLY, COMMAND_CLASS_BATTERY, COMMAND_CLASS_POWERLEVEL, COMMAND_CLASS_VERSION, COMMAND_CLASS_WAKE_UP, COMMAND_CLASS_ASSOCIATION, COMMAND_CLASS_ASSOCIATION_GRP_INFO, COMMAND_CLASS_ALARM, COMMAND_CLASS_CONFIGURATION, COMMAND_CLASS_FIRMWARE_UPDATE_MD], Controlled: [ -- ]]] has been received.
DEBUG 2019-10-14 16:43:05,590 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:05,591 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x2F, 0x00, 0x00, 0x12, 0xD6]
DEBUG 2019-10-14 16:43:05,591 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:05,591 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x2F, 0x00, 0x00, 0x12, 0xD6] has been received.
DEBUG 2019-10-14 16:43:05,593 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x2F, 0x00, 0x00, 0x12, 0xD6] (callback ID=0x2F) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2F)' successfully executed.
DEBUG 2019-10-14 16:43:05,594 (Z-Wave): RX_Session_Layer            : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2F)
ERROR 2019-10-14 16:43:10,595 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_BASIC::BASIC_GET (Retry='1')] failed : 'COMMAND_CLASS_REPORT_TIMEOUT_ERROR'
DEBUG 2019-10-14 16:43:10,596 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_METER_V2]
DEBUG 2019-10-14 16:43:10,600 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_ALARM_V2::ALARM_GET, (Retry='1'), AlarmType='ALARM_TYPE_ACCESS_CONTROL']
DEBUG 2019-10-14 16:43:10,602 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:10,602 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:10,603 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:10,604 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x30)' request (callback ID=0x30).
DEBUG 2019-10-14 16:43:10,605 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x0B, 0x00, 0x13, 0x31, 0x04, 0x71, 0x04, 0x00, 0x06, 0x05, 0x30, 0x94].
DEBUG 2019-10-14 16:43:10,608 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:10,609 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0B]
DEBUG 2019-10-14 16:43:10,610 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:10,612 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:10,613 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:10,614 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:43:10,615 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x71]
DEBUG 2019-10-14 16:43:10,615 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:43:10,616 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:10,616 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,617 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:10,618 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x30]
DEBUG 2019-10-14 16:43:10,620 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:10,620 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x94]
DEBUG 2019-10-14 16:43:10,621 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x0B, 0x00, 0x13, 0x31, 0x04, 0x71, 0x04, 0x00, 0x06, 0x05, 0x30, 0x94] transmission OK.
DEBUG 2019-10-14 16:43:10,622 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x30)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:10,626 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:10,627 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:10,628 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:10,628 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,629 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x30).
DEBUG 2019-10-14 16:43:10,630 (Z-Wave): RX_Session_Layer            : Waiting 64,974 [ms] for 'ZW_SendData' callback frame (callback ID=0x30).
DEBUG 2019-10-14 16:43:10,632 (Z-Wave): RX_Session_Layer            : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=49, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x2F)
DEBUG 2019-10-14 16:43:10,733 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:10,734 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x30, 0x00, 0x00, 0x0B, 0xD0]
DEBUG 2019-10-14 16:43:10,735 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,735 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x30, 0x00, 0x00, 0x0B, 0xD0] has been received.
DEBUG 2019-10-14 16:43:10,736 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x30, 0x00, 0x00, 0x0B, 0xD0] (callback ID=0x30) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x30)' successfully executed.
DEBUG 2019-10-14 16:43:10,737 (Z-Wave): RX_Session_Layer            : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x30)
DEBUG 2019-10-14 16:43:10,801 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:10,806 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x0F, 0x00, 0x04, 0x00, 0x31, 0x09, 0x71, 0x05, 0x06, 0x00, 0x00, 0xFF, 0x06, 0xFE, 0x00, 0xB9]
DEBUG 2019-10-14 16:43:10,807 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,807 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x0F, 0x00, 0x04, 0x00, 0x31, 0x09, 0x71, 0x05, 0x06, 0x00, 0x00, 0xFF, 0x06, 0xFE, 0x00, 0xB9] has been received.
DEBUG 2019-10-14 16:43:10,808 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_ALARM_V2::ALARM_REPORT (Retry='1'), AlarmType='ALARM_TYPE_ACCESS_CONTROL', AlarmTypeValue='0x06', AlarmEvent='EVENT_UNKNWON', AlarmEventValue='0xFE']
DEBUG 2019-10-14 16:43:10,809 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_ALARM_V2::ALARM_GET, (Retry='1'), AlarmType='ALARM_TYPE_HOME_SECURITY']
DEBUG 2019-10-14 16:43:10,810 (Z-Wave): RX_Session_Layer            : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x06], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x30)
DEBUG 2019-10-14 16:43:10,810 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:10,811 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:10,810 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:10,812 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x31)' request (callback ID=0x31).
DEBUG 2019-10-14 16:43:10,813 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x0B, 0x00, 0x13, 0x31, 0x04, 0x71, 0x04, 0x00, 0x07, 0x05, 0x31, 0x94].
DEBUG 2019-10-14 16:43:10,814 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:10,815 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0B]
DEBUG 2019-10-14 16:43:10,816 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:10,817 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:10,818 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:10,818 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:43:10,819 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x71]
DEBUG 2019-10-14 16:43:10,820 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x04]
DEBUG 2019-10-14 16:43:10,822 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:10,823 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x07]
DEBUG 2019-10-14 16:43:10,824 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:10,824 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x31]
DEBUG 2019-10-14 16:43:10,825 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x94]
DEBUG 2019-10-14 16:43:10,834 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:10,834 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:10,835 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x0B, 0x00, 0x13, 0x31, 0x04, 0x71, 0x04, 0x00, 0x07, 0x05, 0x31, 0x94] transmission OK.
DEBUG 2019-10-14 16:43:10,836 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x31)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:10,840 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:10,840 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,840 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x31).
DEBUG 2019-10-14 16:43:10,840 (Z-Wave): RX_Session_Layer            : Waiting 64,972 [ms] for 'ZW_SendData' callback frame (callback ID=0x31).
DEBUG 2019-10-14 16:43:10,912 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:10,912 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x31, 0x00, 0x00, 0x09, 0xD3]
DEBUG 2019-10-14 16:43:10,913 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x31, 0x00, 0x00, 0x09, 0xD3] has been received.
DEBUG 2019-10-14 16:43:10,913 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,913 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x31, 0x00, 0x00, 0x09, 0xD3] (callback ID=0x31) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x31)' successfully executed.
DEBUG 2019-10-14 16:43:10,914 (Z-Wave): RX_Session_Layer            : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x31)
DEBUG 2019-10-14 16:43:10,952 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:10,952 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x0F, 0x00, 0x04, 0x00, 0x31, 0x09, 0x71, 0x05, 0x07, 0x00, 0x00, 0xFF, 0x07, 0xFE, 0x00, 0xB9]
DEBUG 2019-10-14 16:43:10,953 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:10,953 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x0F, 0x00, 0x04, 0x00, 0x31, 0x09, 0x71, 0x05, 0x07, 0x00, 0x00, 0xFF, 0x07, 0xFE, 0x00, 0xB9] has been received.
DEBUG 2019-10-14 16:43:10,954 (Z-Wave): Node_Initializer            : Node '49:0' : [COMMAND_CLASS_ALARM_V2::ALARM_REPORT (Retry='1'), AlarmType='ALARM_TYPE_HOME_SECURITY', AlarmTypeValue='0x07', AlarmEvent='EVENT_UNKNWON', AlarmEventValue='0xFE']
DEBUG 2019-10-14 16:43:10,954 (Z-Wave): RX_Session_Layer            : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=49, Payload=[0x71, 0x04, 0x00, 0x07], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x31)
DEBUG 2019-10-14 16:43:10,956 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_MANUFACTURER_SPECIFIC]
DEBUG 2019-10-14 16:43:10,956 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_WAKE_UP_V2]
DEBUG 2019-10-14 16:43:10,957 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_ASSOCIATION_V2]
DEBUG 2019-10-14 16:43:10,957 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_VERSION]
DEBUG 2019-10-14 16:43:10,957 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_ASSOCIATION_GRP_INFO]
DEBUG 2019-10-14 16:43:10,957 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_DEVICE_RESET_LOCALLY]
DEBUG 2019-10-14 16:43:10,957 (Z-Wave): Node_Initializer            : Node '49' : ------ Update dynamic data of : [COMMAND_CLASS_ZWAVEPLUS_INFO_V2]
INFO 2019-10-14 16:43:10,957 (Z-Wave): Node '49' : Node [Manufacturer='Vision Security', Type='Unknown'] has been successfully initialized.
DEBUG 2019-10-14 16:43:20,781 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:20,782 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:43:20,783 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:43:20,784 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:20,785 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:43:20,786 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:43:20,787 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[E0, 49, C2, EF, 4B, B7, 05, 50]]
DEBUG 2019-10-14 16:43:20,788 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:20,788 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:20,789 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:20,790 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x32)' request (callback ID=0x32).
DEBUG 2019-10-14 16:43:20,792 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50, 0x05, 0x32, 0xC0].
DEBUG 2019-10-14 16:43:20,793 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:20,794 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:43:20,800 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:20,802 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:20,803 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:43:20,804 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:43:20,804 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:43:20,805 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:43:20,806 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xE0]
DEBUG 2019-10-14 16:43:20,806 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x49]
DEBUG 2019-10-14 16:43:20,807 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC2]
DEBUG 2019-10-14 16:43:20,807 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xEF]
DEBUG 2019-10-14 16:43:20,808 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x4B]
DEBUG 2019-10-14 16:43:20,808 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xB7]
DEBUG 2019-10-14 16:43:20,809 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:20,809 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x50]
DEBUG 2019-10-14 16:43:20,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:20,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x32]
DEBUG 2019-10-14 16:43:20,810 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC0]
DEBUG 2019-10-14 16:43:20,811 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:20,812 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50, 0x05, 0x32, 0xC0] transmission OK.
DEBUG 2019-10-14 16:43:20,814 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x32)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:20,818 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:20,819 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:20,819 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:20,819 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:20,820 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x32).
DEBUG 2019-10-14 16:43:20,821 (Z-Wave): RX_Session_Layer            : Waiting 64,970 [ms] for 'ZW_SendData' callback frame (callback ID=0x32).
DEBUG 2019-10-14 16:43:20,858 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:20,858 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x32, 0x00, 0x00, 0x04, 0xDD]
DEBUG 2019-10-14 16:43:20,859 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x32, 0x00, 0x00, 0x04, 0xDD] has been received.
DEBUG 2019-10-14 16:43:20,859 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:20,859 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x32, 0x00, 0x00, 0x04, 0xDD] (callback ID=0x32) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xE0, 0x49, 0xC2, 0xEF, 0x4B, 0xB7, 0x05, 0x50], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x32)' successfully executed.
DEBUG 2019-10-14 16:43:20,860 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[E0, 49, C2, EF, 4B, B7, 05, 50]] succeeded
DEBUG 2019-10-14 16:43:20,941 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:20,942 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x4F, 0x31, 0x35, 0xFA, 0x71, 0xB6, 0x44, 0x64, 0x3F, 0xC2, 0x3D, 0xC4, 0xE0, 0xB1, 0xEB, 0xB5, 0xA8, 0xB7, 0x09, 0xE0, 0x8F, 0xB7]
DEBUG 2019-10-14 16:43:20,943 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x40, 0xD9, 0x2C, 0x22, 0xA1, 0x57, 0x1F]
DEBUG 2019-10-14 16:43:20,943 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:20,944 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x24, 0x00, 0x04, 0x00, 0x35, 0x1E, 0x98, 0x81, 0x4F, 0x31, 0x35, 0xFA, 0x71, 0xB6, 0x44, 0x64, 0x3F, 0xC2, 0x3D, 0xC4, 0xE0, 0xB1, 0xEB, 0xB5, 0xA8, 0xB7, 0x09, 0xE0, 0x8F, 0xB7, 0x40, 0xD9, 0x2C, 0x22, 0xA1, 0x57, 0x1F] has been received.
DEBUG 2019-10-14 16:43:20,945 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x4F, 0x31, 0x35, 0xFA, 0x71, 0xB6, 0x44, 0x64, 0x3F, 0xC2, 0x3D, 0xC4, 0xE0, 0xB1, 0xEB, 0xB5, 0xA8, 0xB7, 0x09, 0xE0, 0x8F, 0xB7, 0x40, 0xD9, 0x2C, 0x22, 0xA1, 0x57]]
DEBUG 2019-10-14 16:43:20,947 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_ALARM', Command='0x05', Parameters: [0x00, 0x00, 0x00, 0xFF, 0x06, 0x16, 0x00, 0x00]].
DEBUG 2019-10-14 16:43:20,948 (Z-Wave): CCAlarmV2                   : Node '53:0' : [COMMAND_CLASS_ALARM::ALARM_REPORT, AlarmTypeV1=[Dec:'0' Hex:'0x00'], AlarmLevelV1=[Dec:'0' Hex:'0x00'], AlarmStatus='UNSOLICITED_ALARMS_ENABLED', AlarmType=['ALARM_TYPE_ACCESS_CONTROL', Dec:'6', Hex:'0x06'], EventType=['EVENT_DOOR_WINDOW_OPEN', Dec:'22', Hex: '0x16']].
DEBUG 2019-10-14 16:43:21,679 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:21,680 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C]
DEBUG 2019-10-14 16:43:21,681 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x08, 0x00, 0x04, 0x00, 0x35, 0x02, 0x98, 0x40, 0x1C] has been received.
DEBUG 2019-10-14 16:43:21,681 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:21,682 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x40', Parameters: [ - ]]
DEBUG 2019-10-14 16:43:21,682 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_GET] received.
DEBUG 2019-10-14 16:43:21,683 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[F9, C8, ED, 0D, 5E, 63, 6C, E3]]
DEBUG 2019-10-14 16:43:21,684 (Z-Wave): Controller_API              : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:21,684 (Z-Wave): Controller_API              : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'.
DEBUG 2019-10-14 16:43:21,685 (Z-Wave): TX_Session_Layer            : Executing Z-Wave function call 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'...
DEBUG 2019-10-14 16:43:21,686 (Z-Wave): TX_Session_Layer            : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x33)' request (callback ID=0x33).
DEBUG 2019-10-14 16:43:21,687 (Z-Wave): TX_Frame_Layer              : Send data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3, 0x05, 0x33, 0x8F].
DEBUG 2019-10-14 16:43:21,688 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x01]
DEBUG 2019-10-14 16:43:21,688 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x11]
DEBUG 2019-10-14 16:43:21,689 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x00]
DEBUG 2019-10-14 16:43:21,689 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x13]
DEBUG 2019-10-14 16:43:21,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x35]
DEBUG 2019-10-14 16:43:21,690 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0A]
DEBUG 2019-10-14 16:43:21,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x98]
DEBUG 2019-10-14 16:43:21,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x80]
DEBUG 2019-10-14 16:43:21,691 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xF9]
DEBUG 2019-10-14 16:43:21,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xC8]
DEBUG 2019-10-14 16:43:21,692 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xED]
DEBUG 2019-10-14 16:43:21,693 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x0D]
DEBUG 2019-10-14 16:43:21,693 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x5E]
DEBUG 2019-10-14 16:43:21,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x63]
DEBUG 2019-10-14 16:43:21,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x6C]
DEBUG 2019-10-14 16:43:21,694 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0xE3]
DEBUG 2019-10-14 16:43:21,695 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x05]
DEBUG 2019-10-14 16:43:21,695 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x33]
DEBUG 2019-10-14 16:43:21,696 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x8F]
DEBUG 2019-10-14 16:43:21,696 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x06]
DEBUG 2019-10-14 16:43:21,697 (Z-Wave): RX_Frame_Layer              : ACK -> Data frame [0x01, 0x11, 0x00, 0x13, 0x35, 0x0A, 0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3, 0x05, 0x33, 0x8F] transmission OK.
DEBUG 2019-10-14 16:43:21,698 (Z-Wave): RX_Session_Layer            : ACK -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x33)' has been successfully sent - waiting 5,000 [ms] for response frame.
DEBUG 2019-10-14 16:43:21,702 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:21,702 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8]
DEBUG 2019-10-14 16:43:21,703 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received.
DEBUG 2019-10-14 16:43:21,703 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:21,703 (Z-Wave): RX_Session_Layer            : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x33).
DEBUG 2019-10-14 16:43:21,704 (Z-Wave): RX_Session_Layer            : Waiting 64,982 [ms] for 'ZW_SendData' callback frame (callback ID=0x33).
DEBUG 2019-10-14 16:43:21,788 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:21,789 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x07, 0x00, 0x13, 0x33, 0x00, 0x00, 0x09, 0xD1]
DEBUG 2019-10-14 16:43:21,790 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x07, 0x00, 0x13, 0x33, 0x00, 0x00, 0x09, 0xD1] has been received.
DEBUG 2019-10-14 16:43:21,790 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:21,791 (Z-Wave): RX_Session_Layer            : Callback [0x01, 0x07, 0x00, 0x13, 0x33, 0x00, 0x00, 0x09, 0xD1] (callback ID=0x33) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=53, Payload=[0x98, 0x80, 0xF9, 0xC8, 0xED, 0x0D, 0x5E, 0x63, 0x6C, 0xE3], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x33)' successfully executed.
DEBUG 2019-10-14 16:43:21,792 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_NONCE_REPORT, Nonce=[F9, C8, ED, 0D, 5E, 63, 6C, E3]] succeeded
DEBUG 2019-10-14 16:43:21,870 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x01]
DEBUG 2019-10-14 16:43:21,871 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x1D, 0x00, 0x04, 0x00, 0x35, 0x17, 0x98, 0x81, 0x61, 0xC9, 0xF5, 0x85, 0x1C, 0x24, 0xEA, 0xCD, 0xC5]
DEBUG 2019-10-14 16:43:21,872 (Z-Wave): RX_Serial_Port_RXTX         : Data bytes read : [0x1F, 0xBD, 0xCC, 0xF9, 0xB8, 0x34, 0x31, 0x14, 0x4C, 0x3D, 0x5F, 0x58, 0x97]
DEBUG 2019-10-14 16:43:21,872 (Z-Wave): TX_Serial_Port_RXTX         : Data byte sent : [0x06]
DEBUG 2019-10-14 16:43:21,873 (Z-Wave): RX_Frame_Layer              : Data frame [0x01, 0x1D, 0x00, 0x04, 0x00, 0x35, 0x17, 0x98, 0x81, 0x61, 0xC9, 0xF5, 0x85, 0x1C, 0x24, 0xEA, 0xCD, 0xC5, 0x1F, 0xBD, 0xCC, 0xF9, 0xB8, 0x34, 0x31, 0x14, 0x4C, 0x3D, 0x5F, 0x58, 0x97] has been received.
DEBUG 2019-10-14 16:43:21,875 (Z-Wave): RX_Session_Layer            : Node '53' : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x81', Parameters: [0x61, 0xC9, 0xF5, 0x85, 0x1C, 0x24, 0xEA, 0xCD, 0xC5, 0x1F, 0xBD, 0xCC, 0xF9, 0xB8, 0x34, 0x31, 0x14, 0x4C, 0x3D, 0x5F, 0x58]]
DEBUG 2019-10-14 16:43:21,877 (Z-Wave): CCSecurity                  : Node '53' : [COMMAND_CLASS_SECURITY::SECURITY_MESSAGE_ENCAPSULATION] --> Decrypted : [APP_CMD_HANDLER_FRAME : NodeID='53', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_BATTERY', Command='0x03', Parameters: [0x64]].
DEBUG 2019-10-14 16:43:21,877 (Z-Wave): CCBattery                   : Node '53:0' : [COMMAND_CLASS_BATTERY::BATTERY_REPORT, BatteryLevel='100'].