DEBUG 2020-02-11 06:46:06,434 (Z-Wave): Command_Builder : Building Z-Wave command DEBUG 2020-02-11 06:46:06,434 (Z-Wave): Command_Builder : Z-Wave command: nodeId = '1', endPoint = '0' DEBUG 2020-02-11 06:46:06,434 (Z-Wave): Command_Builder : Z-Wave command: command = SECURE_INCLUSION_MODE_ON DEBUG 2020-02-11 06:46:06,434 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x00)'... DEBUG 2020-02-11 06:46:06,434 (Z-Wave): TX_Session_Layer : Sending Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' call. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x05, 0x00, 0x4A, 0xC1, 0x21, 0x50]. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x05, 0x00, 0x4A, 0xC1, 0x21, 0x50] transmission OK. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' has been successfully sent --> waiting '10 000' [ms] for 'ADD_NODE_STATUS_LEARN_READY' callback. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x07, 0x00, 0x4A, 0x21, 0x01, 0x00, 0x00, 0x92] DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x07, 0x00, 0x4A, 0x21, 0x01, 0x00, 0x00, 0x92] has been received. DEBUG 2020-02-11 06:46:06,434 (Z-Wave): RX_Session_Layer : Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' has received 'ADD_NODE_STATUS_LEARN_READY' callback --> waiting '60 000' [ms] for 'ADD_NODE_STATUS_NODE_FOUND' callback. DEBUG 2020-02-11 06:46:17,847 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:17,847 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x07, 0x00, 0x4A, 0x21, 0x02, 0x00, 0x00, 0x91] DEBUG 2020-02-11 06:46:17,847 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x07, 0x00, 0x4A, 0x21, 0x02, 0x00, 0x00, 0x91] has been received. DEBUG 2020-02-11 06:46:17,847 (Z-Wave): RX_Session_Layer : Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' has received 'ADD_NODE_STATUS_NODE_FOUND' callback frame [Status: ADD_NODE_STATUS_NODE_FOUND, Callback ID: 0x21, Node ID: 0, Device Classes: [Basic: 0x00, Generic: 0x00, Specific: 0x00], Command Classes: [Supported: [ -- ], Controlled: [ -- ]]] --> waiting '76 000' [ms] for 'ADD_NODE_STATUS_ADDING_SLAVE' or 'ADD_NODE_STATUS_ADDING_CONTROLLER' callback. DEBUG 2020-02-11 06:46:18,052 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:18,052 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x10, 0x00, 0x4A, 0x21, 0x03, 0x3C, 0x09, 0x04, 0x40, 0x03, 0x5E, 0x98, 0x9F, 0x55, 0x72, 0x8A, 0x01] DEBUG 2020-02-11 06:46:18,052 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x10, 0x00, 0x4A, 0x21, 0x03, 0x3C, 0x09, 0x04, 0x40, 0x03, 0x5E, 0x98, 0x9F, 0x55, 0x72, 0x8A, 0x01] has been received. DEBUG 2020-02-11 06:46:18,053 (Z-Wave): RX_Session_Layer : Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' has received 'ADD_NODE_STATUS_ADDING_SLAVE' callback frame [Status: ADD_NODE_STATUS_ADDING_SLAVE, Callback ID: 0x21, Node ID: 60, Device Classes: [Basic: 0x04, Generic: 0x40, Specific: 0x03], Command Classes: [Supported: [COMMAND_CLASS_ZWAVEPLUS_INFO, COMMAND_CLASS_SECURITY, 0x9F, COMMAND_CLASS_TRANSPORT_SERVICE, COMMAND_CLASS_MANUFACTURER_SPECIFIC, COMMAND_CLASS_TIME], Controlled: [ -- ]]] --> waiting for 'ADD_NODE_STATUS_PROTOCOL_DONE' callback. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x07, 0x00, 0x4A, 0x21, 0x05, 0x3C, 0x00, 0xAA] DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x07, 0x00, 0x4A, 0x21, 0x05, 0x3C, 0x00, 0xAA] has been received. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Session_Layer : Z-Wave function 'ZW_AddNodeToNetwork(Mode(s)=[ADD_NODE_ANY, ADD_NODE_OPTION_HIGH_POWER, ADD_NODE_OPTION_NETWORK_WIDE], CallbackID=0x21)' has received 'ADD_NODE_STATUS_PROTOCOL_DONE' callback frame [Status: ADD_NODE_STATUS_PROTOCOL_DONE, Callback ID: 0x21, Node ID: 60, Device Classes: [Basic: 0x00, Generic: 0x00, Specific: 0x00], Command Classes: [Supported: [ -- ], Controlled: [ -- ]]]. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): TX_Session_Layer : Sending Z-Wave function 'ZW_AddNodeToNetwork(Mode=ADD_NODE_STOP, callback ID: 0x21)' call. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x05, 0x00, 0x4A, 0x05, 0x21, 0x94]. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x05, 0x00, 0x4A, 0x05, 0x21, 0x94] transmission OK. DEBUG 2020-02-11 06:46:37,362 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_AddNodeToNetwork(Mode=ADD_NODE_STOP, callback ID: 0x21)' has been successfully sent --> waiting '500' [ms] for 'ADD_NODE_STATUS_DONE' callback. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x07, 0x00, 0x4A, 0x21, 0x06, 0x3C, 0x00, 0xA9] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x07, 0x00, 0x4A, 0x21, 0x06, 0x3C, 0x00, 0xA9] has been received. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Session_Layer : Callback received [0x01, 0x07, 0x00, 0x4A, 0x21, 0x06, 0x3C, 0x00, 0xA9] -> Z-Wave function 'ZW_AddNodeToNetwork(Mode=ADD_NODE_STOP, callback ID: 0x21)' successfully executed. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): TX_Session_Layer : Sending Z-Wave function 'ZW_AddNodeToNetwork(Mode=ADD_NODE_STOP)' call. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x04, 0x00, 0x4A, 0x05, 0xB4]. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x04, 0x00, 0x4A, 0x05, 0xB4] transmission OK. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_AddNodeToNetwork(Mode=ADD_NODE_STOP)' successfully executed. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): Inclusion_Manager : Node '60' : [ZWAddNodeToNetwork, Status=ADD_NODE_STATUS_DONE, Supported=[COMMAND_CLASS_ZWAVEPLUS_INFO, COMMAND_CLASS_SECURITY, COMMAND_CLASS_UNKNOWN, COMMAND_CLASS_TRANSPORT_SERVICE, COMMAND_CLASS_MANUFACTURER_SPECIFIC, COMMAND_CLASS_TIME], Controlled=[]] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): Secure_Inclusion_Manager : Node '60' : [COMMAND_CLASS_SECURITY::SECURITY_SCHEME_GET] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'... DEBUG 2020-02-11 06:46:37,418 (Z-Wave): TX_Session_Layer : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' request (callback ID=0x22). DEBUG 2020-02-11 06:46:37,418 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x0A, 0x00, 0x13, 0x3C, 0x03, 0x98, 0x04, 0x00, 0x05, 0x22, 0x62]. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x0A, 0x00, 0x13, 0x3C, 0x03, 0x98, 0x04, 0x00, 0x05, 0x22, 0x62] transmission OK. DEBUG 2020-02-11 06:46:37,418 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:37,446 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:37,446 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8] DEBUG 2020-02-11 06:46:37,446 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received. DEBUG 2020-02-11 06:46:37,446 (Z-Wave): RX_Session_Layer : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x22). DEBUG 2020-02-11 06:46:37,446 (Z-Wave): RX_Session_Layer : Waiting 64 973 [ms] for 'ZW_SendData' callback frame (callback ID=0x22). DEBUG 2020-02-11 06:46:37,472 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:37,472 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x07, 0x00, 0x4A, 0x21, 0x06, 0x3C, 0x00, 0xA9] DEBUG 2020-02-11 06:46:37,472 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x07, 0x00, 0x4A, 0x21, 0x06, 0x3C, 0x00, 0xA9] has been received. DEBUG 2020-02-11 06:46:39,962 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:39,962 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x09, 0x00, 0x04, 0x00, 0x3C, 0x03, 0x98, 0x05, 0x00, 0x50] DEBUG 2020-02-11 06:46:39,962 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x09, 0x00, 0x04, 0x00, 0x3C, 0x03, 0x98, 0x05, 0x00, 0x50] has been received. DEBUG 2020-02-11 06:46:39,962 (Z-Wave): RX_Session_Layer : Node '60' : [APP_CMD_HANDLER_FRAME : NodeID='60', Status=[RECEIVE_STATUS_TYPE_SINGLE], CommandClass='COMMAND_CLASS_SECURITY', Command='0x05', Parameters: [0x00]] DEBUG 2020-02-11 06:46:42,785 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:42,785 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x05, 0x00, 0x13, 0x22, 0x00, 0xCB] DEBUG 2020-02-11 06:46:42,785 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x05, 0x00, 0x13, 0x22, 0x00, 0xCB] has been received. DEBUG 2020-02-11 06:46:42,785 (Z-Wave): RX_Session_Layer : Callback [0x01, 0x05, 0x00, 0x13, 0x22, 0x00, 0xCB] (callback ID=0x22) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22)' successfully executed. DEBUG 2020-02-11 06:46:42,785 (Z-Wave): RX_Session_Layer : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22) ERROR 2020-02-11 06:46:47,795 (Z-Wave): Secure_Inclusion_Manager : Node '60' : [COMMAND_CLASS_SECURITY::SECURITY_SCHEME_GET] failed : 'COMMAND_CLASS_REPORT_TIMEOUT_ERROR'. ERROR 2020-02-11 06:46:47,810 (Z-Wave): Inclusion_Manager : Node '60' : The security enabled Z-Wave node has been added to the *NON SECURE* Z-Wave network because failed to set the network key. DEBUG 2020-02-11 06:46:47,810 (Z-Wave): Controller : Retrieving Z-Wave node info (ID=60)... DEBUG 2020-02-11 06:46:47,818 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:47,818 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:47,818 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'... DEBUG 2020-02-11 06:46:47,818 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x04, 0x00, 0x41, 0x3C, 0x86]. DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x04, 0x00, 0x41, 0x3C, 0x86] transmission OK. DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_GetNodeProtocolInfo(NodeID=60)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] has been received. DEBUG 2020-02-11 06:46:47,820 (Z-Wave): RX_Session_Layer : Response received [0x01, 0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] -> Z-Wave function 'ZW_GetNodeProtocolInfo(NodeID=60)' successfully executed. DEBUG 2020-02-11 06:46:47,821 (Z-Wave): RX_Session_Layer : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=60, Payload=[0x98, 0x04, 0x00], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x22) DEBUG 2020-02-11 06:46:47,821 (Z-Wave): Node_Initializer : Node '60' : [ZW_RequestNodeInfo, (Retry='1')] DEBUG 2020-02-11 06:46:47,821 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:47,821 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_RequestNodeInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:47,821 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_RequestNodeInfo(NodeID=60)'... INFO 2020-02-11 06:46:47,821 (Z-Wave): Controller : Z-Wave node info (ID=60) : [[Device Classes : 'BASIC_TYPE_ROUTING_SLAVE','GENERIC_TYPE_ENTRY_CONTROL','SPECIFIC_TYPE_SECURE_KEYPAD_DOOR_LOCK'],[Capabilities : 'NODEINFO_CAPABILITY_ROUTING'],[Security : 'NODEINFO_SECURITY_FLIRS_WAKEUP_1000','NODEINFO_SECURITY_OPTIONAL_FUNC_SUPPORT']]. DEBUG 2020-02-11 06:46:47,821 (Z-Wave): ZW_RequestNodeInfo : Sending Z-Wave function 'ZW_RequestNodeInfo(NodeID=60)' call. DEBUG 2020-02-11 06:46:47,837 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x04, 0x00, 0x60, 0x3C, 0xA7]. DEBUG 2020-02-11 06:46:47,852 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:47,852 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x04, 0x00, 0x60, 0x3C, 0xA7] transmission OK. DEBUG 2020-02-11 06:46:47,852 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=60)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:47,856 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:47,856 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x04, 0x01, 0x60, 0x01, 0x9B] DEBUG 2020-02-11 06:46:47,856 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x04, 0x01, 0x60, 0x01, 0x9B] has been received. DEBUG 2020-02-11 06:46:47,856 (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=60)'. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x0F, 0x00, 0x49, 0x84, 0x3C, 0x09, 0x04, 0x40, 0x03, 0x5E, 0x98, 0x9F, 0x55, 0x72, 0x8A, 0xBB] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x0F, 0x00, 0x49, 0x84, 0x3C, 0x09, 0x04, 0x40, 0x03, 0x5E, 0x98, 0x9F, 0x55, 0x72, 0x8A, 0xBB] has been received. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : Callback received [0x01, 0x0F, 0x00, 0x49, 0x84, 0x3C, 0x09, 0x04, 0x40, 0x03, 0x5E, 0x98, 0x9F, 0x55, 0x72, 0x8A, 0xBB] -> Z-Wave function 'ZW_RequestNodeInfo(NodeID=60)' successfully executed. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Node_Initializer : Node '60' : [ZW_RequestNodeInfo, (Retry='1')] succeeded : [[Status: UPDATE_STATE_NODE_INFO_RECEIVED, Node ID: 60, Device Classes: [Basic: BASIC_TYPE_ROUTING_SLAVE, Generic: GENERIC_TYPE_ENTRY_CONTROL, Specific: SPECIFIC_TYPE_SECURE_KEYPAD_DOOR_LOCK], Command Classes: [Supported: [COMMAND_CLASS_ZWAVEPLUS_INFO, COMMAND_CLASS_SECURITY, 0x9F, COMMAND_CLASS_TRANSPORT_SERVICE, COMMAND_CLASS_MANUFACTURER_SPECIFIC, COMMAND_CLASS_TIME], Controlled: [ -- ]]]]. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Node_Initializer : Node '60' : [ZW_GetNodeProtocolInfo]... DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_GetNodeProtocolInfo(NodeID=60)'... DEBUG 2020-02-11 06:46:49,121 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x04, 0x00, 0x41, 0x3C, 0x86]. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x04, 0x00, 0x41, 0x3C, 0x86] transmission OK. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_GetNodeProtocolInfo(NodeID=60)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] has been received. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : Response received [0x01, 0x09, 0x01, 0x41, 0x53, 0xDC, 0x01, 0x04, 0x40, 0x03, 0x7F] -> Z-Wave function 'ZW_GetNodeProtocolInfo(NodeID=60)' successfully executed. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Node_Initializer : Node '60' : [ZW_GetNodeProtocolInfo] : [[Device Classes : 'BASIC_TYPE_ROUTING_SLAVE','GENERIC_TYPE_ENTRY_CONTROL','SPECIFIC_TYPE_SECURE_KEYPAD_DOOR_LOCK'],[Capabilities : 'NODEINFO_CAPABILITY_ROUTING'],[Security : 'NODEINFO_SECURITY_FLIRS_WAKEUP_1000','NODEINFO_SECURITY_OPTIONAL_FUNC_SUPPORT']]. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Node_Initializer : Node '60' : [COMMAND_CLASS_MANUFACTURER_SPECIFIC::MANUFACTURER_SPECIFIC_GET (Retry='1')]... DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'... DEBUG 2020-02-11 06:46:49,121 (Z-Wave): TX_Session_Layer : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' request (callback ID=0x23). DEBUG 2020-02-11 06:46:49,121 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x72, 0x04, 0x05, 0x23, 0x8B]. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x72, 0x04, 0x05, 0x23, 0x8B] transmission OK. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8] DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received. DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x23). DEBUG 2020-02-11 06:46:49,121 (Z-Wave): RX_Session_Layer : Waiting 64 997 [ms] for 'ZW_SendData' callback frame (callback ID=0x23). DEBUG 2020-02-11 06:46:50,348 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:50,348 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x05, 0x00, 0x13, 0x23, 0x00, 0xCA] DEBUG 2020-02-11 06:46:50,348 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x05, 0x00, 0x13, 0x23, 0x00, 0xCA] has been received. DEBUG 2020-02-11 06:46:50,348 (Z-Wave): RX_Session_Layer : Callback [0x01, 0x05, 0x00, 0x13, 0x23, 0x00, 0xCA] (callback ID=0x23) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23)' successfully executed. DEBUG 2020-02-11 06:46:50,348 (Z-Wave): RX_Session_Layer : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23) DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x0E, 0x00, 0x04, 0x00, 0x3C, 0x08, 0x72, 0x05, 0x01, 0x0E, 0x00, 0x09, 0x00, 0x01, 0xB1] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x0E, 0x00, 0x04, 0x00, 0x3C, 0x08, 0x72, 0x05, 0x01, 0x0E, 0x00, 0x09, 0x00, 0x01, 0xB1] has been received. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Node_Initializer : Node '60' : [COMMAND_CLASS_MANUFACTURER_SPECIFIC::MANUFACTURER_SPECIFIC_REPORT (Retry='1'), Manufacturer='Poly-control', ProductTypeID='0x0009', ProductID='0x0001']. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Node_Initializer : Node '60' : Configure parameters... DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Node_Initializer : Node '60' : ====== Init static data of command classes... DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Session_Layer : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=60, Payload=[0x72, 0x04], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x23) DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Node_Initializer : Node '60' : ------ Update static data of : [COMMAND_CLASS_ZWAVEPLUS_INFO] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Node_Initializer : Node '60:0' : [COMMAND_CLASS_ZWAVEPLUS_INFO::ZWAVEPLUS_INFO_GET (Retry='1')] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'... DEBUG 2020-02-11 06:46:50,431 (Z-Wave): TX_Session_Layer : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' request (callback ID=0x24). DEBUG 2020-02-11 06:46:50,431 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x5E, 0x01, 0x05, 0x24, 0xA5]. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x5E, 0x01, 0x05, 0x24, 0xA5] transmission OK. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8] DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received. DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Session_Layer : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x24). DEBUG 2020-02-11 06:46:50,431 (Z-Wave): RX_Session_Layer : Waiting 64 996 [ms] for 'ZW_SendData' callback frame (callback ID=0x24). DEBUG 2020-02-11 06:46:51,664 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:51,664 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x05, 0x00, 0x13, 0x24, 0x00, 0xCD] DEBUG 2020-02-11 06:46:51,664 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x05, 0x00, 0x13, 0x24, 0x00, 0xCD] has been received. DEBUG 2020-02-11 06:46:51,664 (Z-Wave): RX_Session_Layer : Callback [0x01, 0x05, 0x00, 0x13, 0x24, 0x00, 0xCD] (callback ID=0x24) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24)' successfully executed. DEBUG 2020-02-11 06:46:51,664 (Z-Wave): RX_Session_Layer : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24) DEBUG 2020-02-11 06:46:51,736 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x0F, 0x00, 0x04, 0x00, 0x3C, 0x09, 0x5E, 0x02, 0x01, 0x07, 0x00, 0x03, 0x00, 0x03, 0x00, 0x9B] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x0F, 0x00, 0x04, 0x00, 0x3C, 0x09, 0x5E, 0x02, 0x01, 0x07, 0x00, 0x03, 0x00, 0x03, 0x00, 0x9B] has been received. DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60:0' : [COMMAND_CLASS_ZWAVEPLUS_INFO::ZWAVEPLUS_INFO_REPORT (Retry='1'), Version : '1', RoleType : 'ZWAVEPLUS_ROLE_TYPE_SLAVE_SLEEPING_LISTENING', NodeType : 'ZWAVEPLUS_NODE_TYPE_NODE'] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ------ Update static data of : [COMMAND_CLASS_MANUFACTURER_SPECIFIC] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): RX_Session_Layer : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=60, Payload=[0x5E, 0x01], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x24) DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ------ Update static data of : [COMMAND_CLASS_BASIC] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : Configure associations... DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : Configure wake up notification ID... DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ====== Update dynamic data of command classes... DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ------ Update dynamic data of : [COMMAND_CLASS_ZWAVEPLUS_INFO] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ------ Update dynamic data of : [COMMAND_CLASS_MANUFACTURER_SPECIFIC] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60' : ------ Update dynamic data of : [COMMAND_CLASS_BASIC] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Node_Initializer : Node '60:0' : [COMMAND_CLASS_BASIC::BASIC_GET (Retry='1')] DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Controller_API : Enqueue (WORKING-Queue, Count=1) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:51,736 (Z-Wave): Controller_API : Dequeue (WORKING-Queue, Count=0) Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'. DEBUG 2020-02-11 06:46:51,736 (Z-Wave): TX_Session_Layer : Executing Z-Wave function call 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x00)'... DEBUG 2020-02-11 06:46:51,736 (Z-Wave): TX_Session_Layer : Send (repeat count=1) Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' request (callback ID=0x25). DEBUG 2020-02-11 06:46:51,736 (Z-Wave): TX_Frame_Layer : Send data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x20, 0x02, 0x05, 0x25, 0xD9]. DEBUG 2020-02-11 06:46:51,745 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x06] DEBUG 2020-02-11 06:46:51,745 (Z-Wave): RX_Frame_Layer : ACK -> Data frame [0x01, 0x09, 0x00, 0x13, 0x3C, 0x02, 0x20, 0x02, 0x05, 0x25, 0xD9] transmission OK. DEBUG 2020-02-11 06:46:51,745 (Z-Wave): RX_Session_Layer : ACK -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' has been successfully sent - waiting 5 000 [ms] for response frame. DEBUG 2020-02-11 06:46:51,747 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:51,748 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x04, 0x01, 0x13, 0x01, 0xE8] DEBUG 2020-02-11 06:46:51,748 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] has been received. DEBUG 2020-02-11 06:46:51,748 (Z-Wave): RX_Session_Layer : 'ZW_SendData' response [0x01, 0x04, 0x01, 0x13, 0x01, 0xE8] with status 'RETURN_VALUE_TRUE' received (callback ID=0x25). DEBUG 2020-02-11 06:46:51,748 (Z-Wave): RX_Session_Layer : Waiting 64 996 [ms] for 'ZW_SendData' callback frame (callback ID=0x25). DEBUG 2020-02-11 06:46:52,958 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:52,973 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x05, 0x00, 0x13, 0x25, 0x00, 0xCC] DEBUG 2020-02-11 06:46:52,973 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x05, 0x00, 0x13, 0x25, 0x00, 0xCC] has been received. DEBUG 2020-02-11 06:46:52,973 (Z-Wave): RX_Session_Layer : Callback [0x01, 0x05, 0x00, 0x13, 0x25, 0x00, 0xCC] (callback ID=0x25) with state 'TRANSMIT_COMPLETE_OK' received -> Z-Wave function 'ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25)' successfully executed. DEBUG 2020-02-11 06:46:52,973 (Z-Wave): RX_Session_Layer : Add function to pending transaction list (size='1') : ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25) DEBUG 2020-02-11 06:46:53,038 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x01] DEBUG 2020-02-11 06:46:53,038 (Z-Wave): RX_Serial_Port_RXTX : Data bytes read : [0x0B, 0x00, 0x04, 0x00, 0x3C, 0x05, 0x20, 0x03, 0x00, 0xFF, 0xFE, 0xEB] DEBUG 2020-02-11 06:46:53,038 (Z-Wave): RX_Frame_Layer : Data frame [0x01, 0x0B, 0x00, 0x04, 0x00, 0x3C, 0x05, 0x20, 0x03, 0x00, 0xFF, 0xFE, 0xEB] has been received. DEBUG 2020-02-11 06:46:53,038 (Z-Wave): Node_Initializer : Node '60:0' : [COMMAND_CLASS_BASIC::BASIC_REPORT (Retry='1'), Value='0'] DEBUG 2020-02-11 06:46:53,038 (Z-Wave): RX_Session_Layer : Removed function from pending transaction list (size='0') : ZW_SendData(NodeID=60, Payload=[0x20, 0x02], TxOptions=[TRANSMIT_OPTION_AUTO_ROUTE, TRANSMIT_EXPLORE_OPTION_ACK], CallbackID=0x25) INFO 2020-02-11 06:46:53,038 (Z-Wave): Node '60' : Node [Manufacturer='Poly-control', Type='Unknown'] has been successfully initialized. DEBUG 2020-02-11 06:46:53,053 (Z-Wave): Node : Node '60' : Node has been successfully initialized with the following command classes... DEBUG 2020-02-11 06:46:53,053 (Z-Wave): Node : Node '60' : --> 'COMMAND_CLASS_BASIC', 'supported'. DEBUG 2020-02-11 06:46:53,053 (Z-Wave): Node : Node '60' : --> 'COMMAND_CLASS_MANUFACTURER_SPECIFIC', 'supported'. DEBUG 2020-02-11 06:46:53,053 (Z-Wave): Node : Node '60' : --> 'COMMAND_CLASS_ZWAVEPLUS_INFO', 'supported'.