search

OpenZWave / open-zwave

a C++ library to control Z-Wave Networks via a USB Z-Wave Controller.
http://www.openzwave.net/
GNU Lesser General Public License v3.0
1.05k stars 915 forks source link

OpenZWave 1.4.340 crash every time after adding security devices - RealLivingCapTouch #1037

Closed sleep888 closed 8 years ago

sleep888 commented 8 years ago

I got a assa abloy door lock, I used u-stick gen5 as control and Domoticz as UI running on windows 10. I think the pairing process was very smooth and it could pair up successfully and got message "Locked via Lock Button", then crash right after. I have spent quite a long time trying to debug this issue, but did not find root cause. Any idea what may cause this?

The last two line of "OZW_Log.txt" 2016-11-09 22:16:10.073 Info, Node002, Recieved a DoorLockLogging Record 195 which is "Locked via Lock Button" 2016-11-09 22:16:10.073 Detail, Node002, Initial read of value

The full log of "OZW_Log.txt": Logging started 2016-11-09 22:14:02.561

2016-11-09 22:14:02.568 Always, OpenZwave Version 1.4.340 Starting Up 2016-11-09 22:14:02.591 Info, Setting Up Provided Network Key for Secure Communications 2016-11-09 22:14:02.596 Info, mgr, Added driver for controller COM3 2016-11-09 22:14:02.602 Info, Opening controller COM3 2016-11-09 22:14:02.607 Info, Trying to open serial port COM3 (Attempt 1) 2016-11-09 22:14:02.617 Info, Serial port COM3 opened (attempt 1) 2016-11-09 22:14:02.622 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9 2016-11-09 22:14:02.628 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc 2016-11-09 22:14:02.659 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9 2016-11-09 22:14:02.663 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb 2016-11-09 22:14:02.667 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa 2016-11-09 22:14:02.671 Detail, 2016-11-09 22:14:02.675 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9 2016-11-09 22:14:02.682 Detail, contrlr, Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x33, 0x2e, 0x39, 0x35, 0x00, 0x01, 0x99 2016-11-09 22:14:02.686 Detail, 2016-11-09 22:14:02.690 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION: 2016-11-09 22:14:02.694 Info, contrlr, Static Controller library, version Z-Wave 3.95 2016-11-09 22:14:02.698 Detail, Node045, Expected reply was received 2016-11-09 22:14:02.702 Detail, Node045, Message transaction complete 2016-11-09 22:14:02.706 Detail, 2016-11-09 22:14:02.710 Detail, contrlr, Removing current message 2016-11-09 22:14:02.714 Detail, 2016-11-09 22:14:02.718 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc 2016-11-09 22:14:02.724 Detail, contrlr, Received: 0x01, 0x08, 0x01, 0x20, 0xcd, 0x64, 0x71, 0x9a, 0x01, 0x95 2016-11-09 22:14:02.729 Detail, 2016-11-09 22:14:02.733 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xcd64719a. Our node ID = 1 2016-11-09 22:14:02.739 Detail, Node100, Expected reply was received 2016-11-09 22:14:02.744 Detail, Node100, Message transaction complete 2016-11-09 22:14:02.748 Detail, 2016-11-09 22:14:02.753 Detail, contrlr, Removing current message 2016-11-09 22:14:02.758 Detail, 2016-11-09 22:14:02.762 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9 2016-11-09 22:14:02.767 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x05, 0x28, 0xd7 2016-11-09 22:14:02.771 Detail, 2016-11-09 22:14:02.775 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 2016-11-09 22:14:02.780 Info, contrlr, There is no SUC ID Server (SIS) in this network. 2016-11-09 22:14:02.784 Info, contrlr, The PC controller is a primary controller. 2016-11-09 22:14:02.788 Detail, Node215, Expected reply was received 2016-11-09 22:14:02.792 Detail, Node215, Message transaction complete 2016-11-09 22:14:02.796 Detail, 2016-11-09 22:14:02.801 Detail, contrlr, Removing current message 2016-11-09 22:14:02.805 Detail, 2016-11-09 22:14:02.810 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb 2016-11-09 22:14:02.818 Detail, contrlr, Received: 0x01, 0x2b, 0x01, 0x07, 0x01, 0x00, 0x00, 0x86, 0x01, 0x01, 0x00, 0x5a, 0xfe, 0x81, 0xff, 0x88, 0x4f, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x00, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0xfa 2016-11-09 22:14:02.822 Detail, 2016-11-09 22:14:02.827 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES 2016-11-09 22:14:02.831 Info, contrlr, Serial API Version: 1.0 2016-11-09 22:14:02.835 Info, contrlr, Manufacturer ID: 0x0086 2016-11-09 22:14:02.840 Info, contrlr, Product Type: 0x0101 2016-11-09 22:14:02.844 Info, contrlr, Product ID: 0x005a 2016-11-09 22:14:02.849 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7 2016-11-09 22:14:02.853 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe 2016-11-09 22:14:02.858 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97 2016-11-09 22:14:02.862 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9 2016-11-09 22:14:02.866 Detail, Expected reply was received 2016-11-09 22:14:02.871 Detail, Message transaction complete 2016-11-09 22:14:02.875 Detail, 2016-11-09 22:14:02.880 Detail, contrlr, Removing current message 2016-11-09 22:14:02.884 Detail, 2016-11-09 22:14:02.889 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa 2016-11-09 22:14:02.895 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac 2016-11-09 22:14:02.900 Detail, 2016-11-09 22:14:02.904 Info, contrlr, Received reply to GET_SUC_NODE_ID. Node ID = 0 2016-11-09 22:14:02.909 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node 2016-11-09 22:14:02.914 Detail, Node172, Expected reply was received 2016-11-09 22:14:02.918 Detail, Node172, Message transaction complete 2016-11-09 22:14:02.923 Detail, 2016-11-09 22:14:02.927 Detail, contrlr, Removing current message 2016-11-09 22:14:02.929 Detail, 2016-11-09 22:14:02.929 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7 2016-11-09 22:14:02.985 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0x75, 0xb2, 0xdc, 0x9c, 0x13, 0x19, 0x61, 0xd9, 0xe3, 0xca, 0xa0, 0x5e, 0x26, 0xad, 0x31, 0x48, 0x4f, 0xcd, 0xf1, 0xf8, 0x5e, 0x37, 0xe8, 0x5a, 0x8f, 0x7a, 0xd6, 0xe9, 0x4f, 0x22, 0x46, 0x15, 0x52 2016-11-09 22:14:03.007 Detail, 2016-11-09 22:14:03.007 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true 2016-11-09 22:14:03.023 Detail, Node032, Expected reply was received 2016-11-09 22:14:03.038 Detail, Node032, Message transaction complete 2016-11-09 22:14:03.038 Detail, 2016-11-09 22:14:03.054 Detail, contrlr, Removing current message 2016-11-09 22:14:03.070 Detail, 2016-11-09 22:14:03.070 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe 2016-11-09 22:14:03.185 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x02, 0x05, 0x00, 0x1d, 0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x05, 0x00, 0xc5 2016-11-09 22:14:03.185 Detail, 2016-11-09 22:14:03.207 Info, mgr, Driver with Home ID of 0xcd64719a is now ready. 2016-11-09 22:14:03.207 Info, 2016-11-09 22:14:03.223 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA: 2016-11-09 22:14:03.223 Info, contrlr, Node 001 - New 2016-11-09 22:14:03.239 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1 2016-11-09 22:14:03.254 Detail, Node001, QueryStage_ProtocolInfo 2016-11-09 22:14:03.254 Detail, Node001, Queuing (Query) Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb 2016-11-09 22:14:03.270 Detail, Node001, Queuing (Query) Query Stage Complete (ProtocolInfo) 2016-11-09 22:14:03.270 Info, Node001, Initilizing Node. New Node: false (false) 2016-11-09 22:14:03.285 Detail, Expected reply was received 2016-11-09 22:14:03.285 Detail, Message transaction complete 2016-11-09 22:14:03.285 Detail, 2016-11-09 22:14:03.302 Detail, contrlr, Removing current message 2016-11-09 22:14:03.307 Detail, Node001, Notification: DriverReady 2016-11-09 22:14:03.308 Detail, Node001, Notification: NodeNew 2016-11-09 22:14:03.308 Detail, Node001, Notification: NodeAdded 2016-11-09 22:14:03.308 Detail, 2016-11-09 22:14:03.323 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97 2016-11-09 22:14:03.323 Detail, contrlr, Received: 0x01, 0x05, 0x01, 0x06, 0x96, 0x0f, 0x64 2016-11-09 22:14:03.323 Detail, 2016-11-09 22:14:03.339 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS 2016-11-09 22:14:03.339 Detail, Node015, Expected reply was received 2016-11-09 22:14:03.339 Detail, Node015, Message transaction complete 2016-11-09 22:14:03.339 Detail, 2016-11-09 22:14:03.354 Detail, contrlr, Removing current message 2016-11-09 22:14:03.354 Detail, 2016-11-09 22:14:03.354 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x00) - FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9 2016-11-09 22:14:03.370 Detail, contrlr, Removing current message 2016-11-09 22:14:03.370 Detail, 2016-11-09 22:14:03.370 Info, Node001, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb 2016-11-09 22:14:03.386 Detail, Node001, Received: 0x01, 0x09, 0x01, 0x41, 0x93, 0x16, 0x01, 0x02, 0x02, 0x01, 0x33 2016-11-09 22:14:03.386 Detail, 2016-11-09 22:14:03.386 Info, Node001, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO 2016-11-09 22:14:03.386 Info, Node001, Protocol Info for Node 1: 2016-11-09 22:14:03.406 Info, Node001, Listening = true 2016-11-09 22:14:03.408 Info, Node001, Beaming = true 2016-11-09 22:14:03.408 Info, Node001, Routing = false 2016-11-09 22:14:03.408 Info, Node001, Max Baud Rate = 40000 2016-11-09 22:14:03.408 Info, Node001, Version = 4 2016-11-09 22:14:03.424 Info, Node001, Security = false 2016-11-09 22:14:03.424 Info, Node001, Basic device class (0x02) - Static Controller 2016-11-09 22:14:03.424 Info, Node001, Generic device Class (0x02) - Static Controller 2016-11-09 22:14:03.439 Info, Node001, Specific device class (0x01) - Static PC Controller 2016-11-09 22:14:03.439 Info, Node001, COMMAND_CLASS_BASIC is not mapped 2016-11-09 22:14:03.439 Info, Node001, Mandatory Command Classes for Node 1: 2016-11-09 22:14:03.455 Info, Node001, None 2016-11-09 22:14:03.455 Info, Node001, Mandatory Command Classes controlled by Node 1: 2016-11-09 22:14:03.455 Info, Node001, COMMAND_CLASS_BASIC 2016-11-09 22:14:03.455 Detail, Node022, Expected reply was received 2016-11-09 22:14:03.470 Detail, Node022, Message transaction complete 2016-11-09 22:14:03.470 Detail, 2016-11-09 22:14:03.470 Detail, Node001, Removing current message 2016-11-09 22:14:03.486 Detail, Node001, Notification: NodeProtocolInfo 2016-11-09 22:14:03.486 Detail, Node001, Notification: ValueAdded 2016-11-09 22:14:03.486 Detail, Node001, Query Stage Complete (ProtocolInfo) 2016-11-09 22:14:03.502 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 2016-11-09 22:14:03.506 Detail, Node001, QueryStage_Probe 2016-11-09 22:14:03.508 Detail, Node001, QueryStage_WakeUp 2016-11-09 22:14:03.508 Detail, Node001, QueryStage_ManufacturerSpecific1 2016-11-09 22:14:03.508 Detail, Node001, Load Controller Manufacturer Specific Config 2016-11-09 22:14:03.524 Info, Node001, Opening config param file C:\Program Files (x86)\Domoticz\Config/aeotec/zw090.xml 2016-11-09 22:14:03.524 Detail, Node001, QueryStage_NodePlusInfo 2016-11-09 22:14:03.539 Detail, Node001, QueryStage_SecurityReport 2016-11-09 22:14:03.539 Detail, Node001, QueryStage_ManufacturerSpecific2 2016-11-09 22:14:03.539 Detail, Node001, QueryStage_Versions 2016-11-09 22:14:03.555 Detail, Node001, QueryStage_Instances 2016-11-09 22:14:03.555 Info, Node001, Essential node queries are complete 2016-11-09 22:14:03.555 Detail, Node001, QueryStage_Static 2016-11-09 22:14:03.555 Detail, Node001, QueryStage_Associations 2016-11-09 22:14:03.571 Detail, Node001, QueryStage_Neighbors 2016-11-09 22:14:03.571 Detail, Requesting routing info (neighbor list) for Node 1 2016-11-09 22:14:03.571 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a 2016-11-09 22:14:03.586 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors) 2016-11-09 22:14:03.586 Detail, Node001, Notification: EssentialNodeQueriesComplete 2016-11-09 22:14:03.586 Detail, 2016-11-09 22:14:03.606 Info, Node001, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a 2016-11-09 22:14:03.608 Detail, Node001, Received: 0x01, 0x20, 0x01, 0x80, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x5e 2016-11-09 22:14:03.608 Detail, 2016-11-09 22:14:03.624 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO 2016-11-09 22:14:03.624 Info, Node001, Neighbors of this node are: 2016-11-09 22:14:03.640 Info, Node001, (none reported) 2016-11-09 22:14:03.640 Detail, Expected reply was received 2016-11-09 22:14:03.640 Detail, Message transaction complete 2016-11-09 22:14:03.655 Detail, 2016-11-09 22:14:03.655 Detail, Node001, Removing current message 2016-11-09 22:14:03.655 Detail, Node001, Query Stage Complete (Neighbors) 2016-11-09 22:14:03.655 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1 2016-11-09 22:14:03.671 Detail, Node001, QueryStage_Session 2016-11-09 22:14:03.671 Detail, Node001, QueryStage_Dynamic 2016-11-09 22:14:03.671 Detail, Node001, QueryStage_Configuration 2016-11-09 22:14:03.687 Detail, Node001, QueryStage_Complete 2016-11-09 22:14:03.687 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0 2016-11-09 22:14:03.687 Warning, CheckCompletedNodeQueries all=1, deadFound=0 sleepingOnly=1 2016-11-09 22:14:03.703 Info, Node query processing complete. 2016-11-09 22:14:03.708 Detail, Node001, Notification: NodeQueriesComplete 2016-11-09 22:14:03.709 Detail, contrlr, Notification: AllNodesQueried 2016-11-09 22:15:42.655 Detail, Queuing (Controller) Add Device 2016-11-09 22:15:42.687 Info, Add Device 2016-11-09 22:15:42.719 Detail, contrlr, Queuing (Command) ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x0a, 0x7b 2016-11-09 22:15:42.731 Detail, Notification: ControllerComand - Starting 2016-11-09 22:15:42.739 Detail, 2016-11-09 22:15:42.743 Info, contrlr, Sending (Command) message (Callback ID=0x0a, Expected Reply=0x4a) - ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x0a, 0x7b 2016-11-09 22:15:42.755 Detail, contrlr, Received: 0x01, 0x07, 0x00, 0x4a, 0x0a, 0x01, 0x00, 0x00, 0xb9 2016-11-09 22:15:42.759 Detail, 2016-11-09 22:15:42.771 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK: 2016-11-09 22:15:42.783 Info, contrlr, ADD_NODE_STATUS_LEARN_READY 2016-11-09 22:15:42.800 Detail, Node001, Expected callbackId was received 2016-11-09 22:15:42.815 Detail, Node001, Expected reply was received 2016-11-09 22:15:42.827 Detail, Node001, Message transaction complete 2016-11-09 22:15:42.835 Detail, 2016-11-09 22:15:42.839 Detail, contrlr, Removing current message 2016-11-09 22:15:42.843 Detail, Notification: ControllerCommand - Waiting 2016-11-09 22:15:58.834 Detail, Received: 0x01, 0x07, 0x00, 0x4a, 0x0a, 0x02, 0x00, 0x00, 0xba 2016-11-09 22:15:58.838 Detail, 2016-11-09 22:15:58.846 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK: 2016-11-09 22:15:58.850 Info, ADD_NODE_STATUS_NODE_FOUND 2016-11-09 22:15:58.854 Detail, Notification: ControllerCommand - InProgress 2016-11-09 22:15:58.914 Detail, Received: 0x01, 0x0d, 0x00, 0x4a, 0x0a, 0x03, 0x02, 0x06, 0x04, 0x40, 0x03, 0x72, 0x86, 0x98, 0x9e 2016-11-09 22:15:58.917 Detail, 2016-11-09 22:15:58.925 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK: 2016-11-09 22:15:58.929 Info, ADD_NODE_STATUS_ADDING_SLAVE 2016-11-09 22:15:58.933 Info, Adding node ID 2 - Secure 2016-11-09 22:15:58.941 Detail, Notification: ControllerCommand - InProgress 2016-11-09 22:15:59.221 Detail, Received: 0x01, 0x07, 0x00, 0x4a, 0x0a, 0x05, 0x02, 0x00, 0xbf 2016-11-09 22:15:59.225 Detail, 2016-11-09 22:15:59.233 Info, FUNC_ID_ZW_ADD_NODE_TO_NETWORK: 2016-11-09 22:15:59.237 Info, ADD_NODE_STATUS_PROTOCOL_DONE 2016-11-09 22:15:59.241 Detail, contrlr, Queuing (Command) Add Node Stop: 0x01, 0x04, 0x00, 0x4a, 0x05, 0xb4 2016-11-09 22:15:59.245 Detail, Notification: ControllerCommand - InProgress 2016-11-09 22:15:59.253 Detail, 2016-11-09 22:15:59.257 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x4a) - Add Node Stop: 0x01, 0x04, 0x00, 0x4a, 0x05, 0xb4 2016-11-09 22:15:59.315 Detail, contrlr, Received: 0x01, 0x07, 0x00, 0x4a, 0x0a, 0x06, 0x02, 0x00, 0xbc 2016-11-09 22:15:59.322 Detail, 2016-11-09 22:15:59.326 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK: 2016-11-09 22:15:59.334 Info, contrlr, ADD_NODE_STATUS_DONE 2016-11-09 22:15:59.342 Info, Node002, Basic device class (0x04) - Routing Slave 2016-11-09 22:15:59.346 Info, Node002, Generic device Class (0x40) - Entry Control 2016-11-09 22:15:59.354 Info, Node002, Specific device class (0x03) - Secure Keypad Door Lock 2016-11-09 22:15:59.362 Info, Node002, COMMAND_CLASS_BASIC will be mapped to COMMAND_CLASS_DOOR_LOCK 2016-11-09 22:15:59.366 Info, Node002, Mandatory Command Classes for Node 2: 2016-11-09 22:15:59.374 Info, Node002, COMMAND_CLASS_BASIC 2016-11-09 22:15:59.378 Info, Node002, COMMAND_CLASS_DOOR_LOCK 2016-11-09 22:15:59.386 Info, Node002, COMMAND_CLASS_USER_CODE 2016-11-09 22:15:59.390 Info, Node002, COMMAND_CLASS_MANUFACTURER_SPECIFIC 2016-11-09 22:15:59.394 Info, Node002, COMMAND_CLASS_VERSION 2016-11-09 22:15:59.403 Info, Node002, COMMAND_CLASS_SECURITY 2016-11-09 22:15:59.408 Info, Node002, Mandatory Command Classes controlled by Node 2: 2016-11-09 22:15:59.412 Info, Node002, None 2016-11-09 22:15:59.417 Detail, Node002, Queuing (Security) SecurityCmd_SchemeGet (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x98, 0x04, 0x00, 0x25, 0x0b, 0x55 2016-11-09 22:15:59.422 Info, Node002, Optional command classes for node 2: 2016-11-09 22:15:59.426 Info, Node002, COMMAND_CLASS_MANUFACTURER_SPECIFIC (Existing) 2016-11-09 22:15:59.430 Info, Node002, COMMAND_CLASS_VERSION (Existing) 2016-11-09 22:15:59.434 Info, Node002, COMMAND_CLASS_SECURITY (Existing) 2016-11-09 22:15:59.442 Info, Node002, None 2016-11-09 22:15:59.446 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1 2016-11-09 22:15:59.450 Detail, Node002, QueryStage_ProtocolInfo 2016-11-09 22:15:59.454 Detail, Node002, Queuing (Query) Get Node Protocol Info (Node=2): 0x01, 0x04, 0x00, 0x41, 0x02, 0xb8 2016-11-09 22:15:59.462 Detail, Node002, Queuing (Query) Query Stage Complete (ProtocolInfo) 2016-11-09 22:15:59.466 Info, Node002, Initilizing Node. New Node: true (true) 2016-11-09 22:15:59.470 Detail, Node006, Expected reply was received 2016-11-09 22:15:59.474 Detail, Node006, Message transaction complete 2016-11-09 22:15:59.478 Detail, 2016-11-09 22:15:59.486 Detail, contrlr, Removing current message 2016-11-09 22:15:59.490 Detail, Node002, Notification: NodeAdded 2016-11-09 22:15:59.566 Info, mgr, Manager::WriteConfig completed for driver with home ID of 0xcd64719a 2016-11-09 22:15:59.574 Detail, Node002, Notification: NodeProtocolInfo 2016-11-09 22:15:59.582 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.736 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.744 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.752 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.760 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.764 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.776 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.784 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.792 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.796 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.800 Detail, Node002, Notification: ValueAdded 2016-11-09 22:15:59.809 Detail, Notification: ControllerCommand - Completed 2016-11-09 22:15:59.813 Detail, 2016-11-09 22:15:59.818 Info, Node002, Sending (Security) message (Callback ID=0x0b, Expected Reply=0x04) - SecurityCmd_SchemeGet (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x98, 0x04, 0x00, 0x25, 0x0b, 0x55 2016-11-09 22:15:59.834 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:15:59.846 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:00.978 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0b, 0x00, 0x00, 0x73, 0x93 2016-11-09 22:16:01.014 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0b received (expected 0x0b) 2016-11-09 22:16:01.043 Info, Node002, Request RTT 1221 Average Request RTT 1221 2016-11-09 22:16:01.051 Detail, Expected callbackId was received 2016-11-09 22:16:01.059 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x98, 0x05, 0x00, 0x6e 2016-11-09 22:16:01.063 Detail, 2016-11-09 22:16:01.071 Info, Node002, Response RTT 1249 Average Response RTT 1249 2016-11-09 22:16:01.075 Info, Node002, Received SecurityCmd_SchemeReport from node 2: 0 2016-11-09 22:16:01.079 Info, Node002, Security scheme agreed. 2016-11-09 22:16:01.087 Detail, Node002, Queuing (Security) SecurityCmd_NetworkKeySet (Node=2): 0x01, 0x19, 0x00, 0x13, 0x02, 0x12, 0x98, 0x06, 0x01, 0x02, 0x03, 0x04, 0x05, 0x06, 0x07, 0x08, 0x09, 0x0a, 0x0b, 0x0c, 0x0d, 0x0e, 0x0f, 0x10, 0x25, 0x0c, 0x42 2016-11-09 22:16:01.091 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:01.095 Detail, Node002, Message transaction complete 2016-11-09 22:16:01.104 Detail, 2016-11-09 22:16:01.109 Detail, Node002, Removing current message 2016-11-09 22:16:01.114 Detail, 2016-11-09 22:16:01.119 Info, Node002, Processing (Security) Nonce Request message (Callback ID=0x0c, Expected Reply=0x04) 2016-11-09 22:16:01.123 Info, Node002, Sending (Security) message (Callback ID=0x0c, Expected Reply=0x04) - Nonce_Get(SecurityCmd_NetworkKeySet) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:01.135 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.139 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:01.151 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:01.155 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:01.159 Info, Node002, Request RTT 31 Average Request RTT 626 2016-11-09 22:16:01.167 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x71, 0xf3, 0x21, 0xbf, 0x2f, 0xbc, 0x4b, 0x29, 0x16 2016-11-09 22:16:01.171 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:01.179 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.183 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.187 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.191 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.195 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.205 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.210 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.214 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.219 Info, Node002, Sending (Security) message (Callback ID=0x0d, Expected Reply=0x04) - SecurityCmd_NetworkKeySet (Node=2): 0x01, 0x19, 0x00, 0x13, 0x02, 0x12, 0x98, 0x06, 0x01, 0x02, 0x03, 0x04, 0x05, 0x06, 0x07, 0x08, 0x09, 0x0a, 0x0b, 0x0c, 0x0d, 0x0e, 0x0f, 0x10, 0x25, 0x0d, 0x43 2016-11-09 22:16:01.235 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.239 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:01.259 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0d, 0x00, 0x00, 0x03, 0xe5 2016-11-09 22:16:01.263 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0d received (expected 0x0d) 2016-11-09 22:16:01.271 Info, Node002, Request RTT 144 Average Request RTT 385 2016-11-09 22:16:01.275 Detail, Expected callbackId was received 2016-11-09 22:16:01.310 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:01.316 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:01.319 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:01.327 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.331 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.339 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.343 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.351 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.359 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.363 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:01.367 Info, Node002, Sending (Security) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22, 0x05, 0x01, 0x35: 2016-11-09 22:16:01.383 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.387 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:01.399 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:01.408 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:01.413 Info, Node002, Request RTT 285 Average Request RTT 335 2016-11-09 22:16:01.423 Detail, Node002, Received: 0x01, 0x1c, 0x00, 0x04, 0x00, 0x02, 0x16, 0x98, 0x81, 0x3c, 0x6c, 0x43, 0x31, 0x90, 0x6f, 0x9f, 0x97, 0xe6, 0x1c, 0xb9, 0x2a, 0x06, 0x21, 0x0c, 0x72, 0xf0, 0x66, 0x68, 0xdc, 0x2d 2016-11-09 22:16:01.427 Info, Raw: 0x98, 0x81, 0x3c, 0x6c, 0x43, 0x31, 0x90, 0x6f, 0x9f, 0x97, 0xe6, 0x1c, 0xb9, 0x2a, 0x06, 0x21, 0x0c, 0x72, 0xf0, 0x66, 0x68, 0xdc, 0x2d 2016-11-09 22:16:01.431 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.439 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.443 Detail, Node002, Decrypted Packet: 0x44, 0x96, 0x92 2016-11-09 22:16:01.447 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.455 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.459 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.463 Info, Node001, Setting Up Inclusion Network Key for Secure Communications 2016-11-09 22:16:01.471 Warning, Node002, MAC Authentication of Packet Failed. Dropping 2016-11-09 22:16:01.475 Detail, Node002, Removing current message 2016-11-09 22:16:01.479 Detail, 2016-11-09 22:16:01.483 Info, Node002, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=2): 0x01, 0x04, 0x00, 0x41, 0x02, 0xb8 2016-11-09 22:16:01.491 Detail, Node002, Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0xdc, 0x00, 0x04, 0x40, 0x03, 0x7e 2016-11-09 22:16:01.499 Detail, 2016-11-09 22:16:01.505 Info, Node002, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO 2016-11-09 22:16:01.510 Info, Node002, Protocol Info for Node 2: 2016-11-09 22:16:01.514 Info, Node002, Listening = false 2016-11-09 22:16:01.519 Info, Node002, Frequent = true 2016-11-09 22:16:01.523 Info, Node002, Beaming = true 2016-11-09 22:16:01.527 Info, Node002, Routing = true 2016-11-09 22:16:01.531 Info, Node002, Max Baud Rate = 40000 2016-11-09 22:16:01.539 Info, Node002, Version = 4 2016-11-09 22:16:01.543 Info, Node002, Security = false 2016-11-09 22:16:01.547 Detail, Node220, Expected reply was received 2016-11-09 22:16:01.551 Detail, Node220, Message transaction complete 2016-11-09 22:16:01.559 Detail, 2016-11-09 22:16:01.563 Detail, Node002, Removing current message 2016-11-09 22:16:01.567 Detail, Node002, Query Stage Complete (ProtocolInfo) 2016-11-09 22:16:01.571 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 2016-11-09 22:16:01.575 Detail, Node002, QueryStage_Probe 2016-11-09 22:16:01.583 Info, Node002, NoOperation::Set - Routing=true 2016-11-09 22:16:01.591 Detail, Node002, Queuing (NoOp) NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0e, 0xce 2016-11-09 22:16:01.595 Detail, Node002, Queuing (Query) Query Stage Complete (Probe) 2016-11-09 22:16:01.599 Detail, 2016-11-09 22:16:01.608 Info, Node002, Sending (NoOp) message (Callback ID=0x0e, Expected Reply=0x13) - NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0e, 0xce 2016-11-09 22:16:01.619 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.623 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:01.635 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0e, 0x00, 0x00, 0x02, 0xe7 2016-11-09 22:16:01.639 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e) 2016-11-09 22:16:01.647 Info, Node002, Request RTT 35 Average Request RTT 185 2016-11-09 22:16:01.651 Detail, Expected callbackId was received 2016-11-09 22:16:01.655 Detail, Expected reply was received 2016-11-09 22:16:01.663 Detail, Message transaction complete 2016-11-09 22:16:01.667 Detail, 2016-11-09 22:16:01.671 Detail, Node002, Removing current message 2016-11-09 22:16:01.714 Detail, Node002, Notification: Notification - NoOperation 2016-11-09 22:16:01.719 Detail, Node002, Query Stage Complete (Probe) 2016-11-09 22:16:01.723 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 2016-11-09 22:16:01.727 Detail, Node002, QueryStage_WakeUp 2016-11-09 22:16:01.731 Detail, Node002, QueryStage_ManufacturerSpecific1 2016-11-09 22:16:01.739 Detail, Node002, Checking for ManufacturerSpecific CC and Requesting values if present on this node 2016-11-09 22:16:01.743 Detail, Node002, Queuing (Query) ManufacturerSpecificCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x72, 0x04, 0x25, 0x0f, 0xb9 2016-11-09 22:16:01.747 Detail, Node002, Queuing (Query) Query Stage Complete (ManufacturerSpecific1) 2016-11-09 22:16:01.751 Detail, 2016-11-09 22:16:01.759 Info, Node002, Sending (Query) message (Callback ID=0x0f, Expected Reply=0x04) - ManufacturerSpecificCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x72, 0x04, 0x25, 0x0f, 0xb9 2016-11-09 22:16:01.771 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.775 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:01.788 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x0f, 0x00, 0x00, 0x02, 0xe6 2016-11-09 22:16:01.795 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0f received (expected 0x0f) 2016-11-09 22:16:01.807 Info, Node002, Request RTT 44 Average Request RTT 114 2016-11-09 22:16:01.814 Detail, Expected callbackId was received 2016-11-09 22:16:01.819 Detail, Node002, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x02, 0x08, 0x72, 0x05, 0x01, 0x29, 0x00, 0x02, 0x00, 0x00, 0xa2 2016-11-09 22:16:01.823 Detail, 2016-11-09 22:16:01.827 Info, Node002, Response RTT 64 Average Response RTT 656 2016-11-09 22:16:01.831 Info, Node002, Opening config param file C:\Program Files (x86)\Domoticz\Config/assa_abloy/RealLivingCapTouch.xml 2016-11-09 22:16:01.839 Info, Node002, Received manufacturer specific report from node 2: Manufacturer=Assa Abloy, Product=Yale Real Living Cap-Touch Deadbolt 2016-11-09 22:16:01.843 Info, Node002, Node Identity Codes: 0129:0002:0000 2016-11-09 22:16:01.847 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:01.851 Detail, Node002, Message transaction complete 2016-11-09 22:16:01.855 Detail, 2016-11-09 22:16:01.859 Detail, Node002, Removing current message 2016-11-09 22:16:01.867 Detail, Node002, Notification: NodeNaming 2016-11-09 22:16:01.931 Detail, Node002, Query Stage Complete (ManufacturerSpecific1) 2016-11-09 22:16:01.939 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=NodeInfo live=1 2016-11-09 22:16:01.945 Detail, Node002, QueryStage_NodePlusInfo 2016-11-09 22:16:01.949 Detail, Node002, QueryStage_SecurityReport 2016-11-09 22:16:01.957 Detail, Node002, Queuing (Security) SecurityCmd_SupportedGet (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x02, 0x25, 0x10, 0x4a 2016-11-09 22:16:01.961 Detail, Node002, Queuing (Query) Query Stage Complete (SecurityReport) 2016-11-09 22:16:01.965 Detail, 2016-11-09 22:16:01.973 Info, Node002, Processing (Security) Nonce Request message (Callback ID=0x10, Expected Reply=0x04) 2016-11-09 22:16:01.977 Info, Node002, Sending (Security) message (Callback ID=0x10, Expected Reply=0x04) - Nonce_Get(SecurityCmd_SupportedGet) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:01.989 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:01.993 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:02.008 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:02.013 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:02.019 Info, Node002, Request RTT 38 Average Request RTT 76 2016-11-09 22:16:02.027 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xe6, 0xd2, 0xdf, 0x98, 0x51, 0x72, 0xf6, 0xac, 0xf1 2016-11-09 22:16:02.031 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:02.039 Info, Node001, Setting Up Provided Network Key for Secure Communications 2016-11-09 22:16:02.043 Info, Node002, Sending (Security) message (Callback ID=0x11, Expected Reply=0x04) - SecurityCmd_SupportedGet (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x02, 0x25, 0x11, 0x4b 2016-11-09 22:16:02.055 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:02.063 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:02.079 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x11, 0x00, 0x00, 0x02, 0xf8 2016-11-09 22:16:02.083 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x11 received (expected 0x11) 2016-11-09 22:16:02.091 Info, Node002, Request RTT 110 Average Request RTT 93 2016-11-09 22:16:02.095 Detail, Expected callbackId was received 2016-11-09 22:16:02.099 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:02.107 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:02.112 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:02.116 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:02.119 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.123 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.131 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.135 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.139 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.143 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:02.147 Info, Node002, Sending (Security) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed, 0x05, 0x01, 0xe9: 2016-11-09 22:16:02.163 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:02.167 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:02.179 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:02.187 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:02.191 Info, Node002, Request RTT 210 Average Request RTT 151 2016-11-09 22:16:02.212 Detail, Node002, Received: 0x01, 0x2c, 0x00, 0x04, 0x00, 0x02, 0x26, 0x98, 0x81, 0xf6, 0xd9, 0x18, 0xdb, 0x19, 0xba, 0x45, 0xd5, 0x3e, 0xfc, 0xd8, 0x41, 0xae, 0x0d, 0x8a, 0x67, 0x5e, 0x14, 0x37, 0x00, 0xcb, 0x86, 0x6c, 0x92, 0xe8, 0x02, 0x2d, 0xbc, 0x8a, 0x6c, 0xf3, 0x83, 0x04, 0x5d, 0x97, 0x59, 0x94 2016-11-09 22:16:02.218 Info, Raw: 0x98, 0x81, 0xf6, 0xd9, 0x18, 0xdb, 0x19, 0xba, 0x45, 0xd5, 0x3e, 0xfc, 0xd8, 0x41, 0xae, 0x0d, 0x8a, 0x67, 0x5e, 0x14, 0x37, 0x00, 0xcb, 0x86, 0x6c, 0x92, 0xe8, 0x02, 0x2d, 0xbc, 0x8a, 0x6c, 0xf3, 0x83, 0x04, 0x5d, 0x97, 0x59, 0x94 2016-11-09 22:16:02.223 Detail, Node002, Decrypted Packet: 0x00, 0x98, 0x03, 0x00, 0x72, 0x86, 0x98, 0x62, 0x4c, 0x4e, 0x63, 0x8b, 0x85, 0x71, 0x70, 0x75, 0x80, 0x8a, 0xef 2016-11-09 22:16:02.227 Detail, 2016-11-09 22:16:02.231 Info, Node002, Response RTT 249 Average Response RTT 452 2016-11-09 22:16:02.239 Info, Node002, Received SecurityCmd_SupportedReport from node 2 2016-11-09 22:16:02.243 Detail, Node002, Initial read of value 2016-11-09 22:16:02.247 Info, Node002, Secured command classes for node 2: 2016-11-09 22:16:02.255 Info, Node002, COMMAND_CLASS_MANUFACTURER_SPECIFIC (Secured) - InNIF 2016-11-09 22:16:02.259 Info, Node002, COMMAND_CLASS_VERSION (Secured) - InNIF 2016-11-09 22:16:02.263 Info, Node002, COMMAND_CLASS_DOOR_LOCK (Secured) - NotInNIF 2016-11-09 22:16:02.271 Info, Node002, COMMAND_CLASS_DOOR_LOCK_LOGGING (Secured) - NotInNIF 2016-11-09 22:16:02.275 Info, Node002, Secure CommandClass 0x4e - NOT SUPPORTED 2016-11-09 22:16:02.279 Info, Node002, COMMAND_CLASS_USER_CODE (Secured) - NotInNIF 2016-11-09 22:16:02.283 Info, Node002, COMMAND_CLASS_TIME_PARAMETERS (Secured) - NotInNIF 2016-11-09 22:16:02.291 Info, Node002, COMMAND_CLASS_ASSOCIATION (Secured) - NotInNIF 2016-11-09 22:16:02.295 Info, Node002, COMMAND_CLASS_ALARM (Secured) - NotInNIF 2016-11-09 22:16:02.299 Info, Node002, COMMAND_CLASS_CONFIGURATION (Secured) - NotInNIF 2016-11-09 22:16:02.307 Info, Node002, COMMAND_CLASS_PROTECTION (Secured) - NotInNIF 2016-11-09 22:16:02.311 Info, Node002, COMMAND_CLASS_BATTERY (Secured) - NotInNIF 2016-11-09 22:16:02.315 Info, Node002, Secure CommandClass 0x8a - NOT SUPPORTED 2016-11-09 22:16:02.319 Info, Node002, COMMAND_CLASS_ZWAVE_PLUS_INFO (Secured) - NotInNIF 2016-11-09 22:16:02.323 Info, Node002, UnSecured command classes for node 2: 2016-11-09 22:16:02.327 Info, Node002, COMMAND_CLASS_NO_OPERATION (Unsecured) - NotInNIF 2016-11-09 22:16:02.335 Info, Node002, COMMAND_CLASS_BASIC (Unsecured) - NotInNIF 2016-11-09 22:16:02.339 Info, Node002, COMMAND_CLASS_SECURITY (Unsecured) - InNIF 2016-11-09 22:16:02.343 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:02.347 Detail, Node002, Message transaction complete 2016-11-09 22:16:02.355 Detail, 2016-11-09 22:16:02.359 Detail, Node002, Removing current message 2016-11-09 22:16:02.363 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:02.367 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.375 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.379 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.383 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.391 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.395 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.399 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.407 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.591 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.748 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.759 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.763 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.775 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.779 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:02.791 Detail, Node002, Query Stage Complete (SecurityReport) 2016-11-09 22:16:02.795 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=ManufacturerSpecific2 live=1 2016-11-09 22:16:02.807 Info, Node002, Opening config param file C:\Program Files (x86)\Domoticz\Config/assa_abloy/RealLivingCapTouch.xml 2016-11-09 22:16:02.818 Info, Node002, Value Refresh triggered by CommandClass: COMMAND_CLASS_ALARM, Genre: 1, Instance: 1, Index: 0 for: 2016-11-09 22:16:02.840 Info, Node002, CommandClass: COMMAND_CLASS_DOOR_LOCK, RequestFlags: 0, Instance: 1, Index: 1 2016-11-09 22:16:02.844 Detail, Node002, QueryStage_Versions 2016-11-09 22:16:02.852 Info, Node002, Requesting Versions 2016-11-09 22:16:02.856 Info, Node002, Requesting Versions for COMMAND_CLASS_NO_OPERATION 2016-11-09 22:16:02.860 Info, Node002, Requesting Versions for COMMAND_CLASS_BASIC 2016-11-09 22:16:02.864 Info, Node002, Requesting Versions for COMMAND_CLASS_DOOR_LOCK_LOGGING 2016-11-09 22:16:02.868 Info, Node002, Requesting Versions for COMMAND_CLASS_ZWAVE_PLUS_INFO 2016-11-09 22:16:02.872 Info, Node002, Requesting Versions for COMMAND_CLASS_DOOR_LOCK 2016-11-09 22:16:02.876 Info, Node002, Requesting Versions for COMMAND_CLASS_USER_CODE 2016-11-09 22:16:02.884 Info, Node002, Requesting Versions for COMMAND_CLASS_CONFIGURATION 2016-11-09 22:16:02.888 Info, Node002, Requesting Versions for COMMAND_CLASS_ALARM 2016-11-09 22:16:02.888 Info, Node002, ok 2016-11-09 22:16:02.888 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_VERSION 2016-11-09 22:16:02.888 Detail, Node002, Queuing (Send) VersionCmd_CommandClassGet (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x86, 0x13, 0x71, 0x25, 0x12, 0x34 2016-11-09 22:16:02.906 Info, Node002, Requesting Versions for COMMAND_CLASS_MANUFACTURER_SPECIFIC 2016-11-09 22:16:02.910 Info, Node002, Requesting Versions for COMMAND_CLASS_PROTECTION 2016-11-09 22:16:02.915 Info, Node002, Requesting Versions for COMMAND_CLASS_BATTERY 2016-11-09 22:16:02.920 Info, Node002, Requesting Versions for COMMAND_CLASS_ASSOCIATION 2016-11-09 22:16:02.920 Info, Node002, Requesting Versions for COMMAND_CLASS_VERSION 2016-11-09 22:16:02.920 Info, Node002, Requesting Versions for COMMAND_CLASS_TIME_PARAMETERS 2016-11-09 22:16:02.920 Info, Node002, Requesting Versions for COMMAND_CLASS_SECURITY 2016-11-09 22:16:02.935 Detail, Node002, Queuing (Query) Query Stage Complete (Versions) 2016-11-09 22:16:02.935 Detail, 2016-11-09 22:16:02.935 Info, Node002, Processing (Send) Nonce Request message (Callback ID=0x12, Expected Reply=0x04) 2016-11-09 22:16:02.951 Info, Node002, Sending (Send) message (Callback ID=0x12, Expected Reply=0x04) - Nonce_Get(VersionCmd_CommandClassGet) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:02.951 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:02.967 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:02.967 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:02.982 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:02.982 Info, Node002, Request RTT 31 Average Request RTT 91 2016-11-09 22:16:02.982 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x04, 0x76, 0x0e, 0xf1, 0x9b, 0x69, 0x47, 0x71, 0xb2 2016-11-09 22:16:02.998 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:02.998 Info, Node002, Sending (Send) message (Callback ID=0x13, Expected Reply=0x04) - VersionCmd_CommandClassGet (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x86, 0x13, 0x71, 0x25, 0x13, 0x35 2016-11-09 22:16:03.017 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.020 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.035 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x13, 0x00, 0x00, 0x02, 0xfa 2016-11-09 22:16:03.035 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x13 received (expected 0x13) 2016-11-09 22:16:03.035 Info, Node002, Request RTT 84 Average Request RTT 87 2016-11-09 22:16:03.051 Detail, Expected callbackId was received 2016-11-09 22:16:03.082 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:03.099 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:03.103 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:03.108 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:03.113 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:03.117 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.120 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.124 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.128 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.128 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.128 Info, Node002, Sending (Send) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a, 0x05, 0x01, 0xaa: 2016-11-09 22:16:03.143 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.143 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.159 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:03.175 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:03.175 Info, Node002, Request RTT 223 Average Request RTT 155 2016-11-09 22:16:03.190 Detail, Node002, Received: 0x01, 0x1e, 0x00, 0x04, 0x00, 0x02, 0x18, 0x98, 0x81, 0xbf, 0x9c, 0x96, 0x10, 0x6d, 0x69, 0x8f, 0xb4, 0xcc, 0x24, 0x85, 0xa0, 0x3c, 0xbf, 0x43, 0xe2, 0x3b, 0x6e, 0xfc, 0x35, 0x5a, 0x4e, 0x1b 2016-11-09 22:16:03.190 Info, Raw: 0x98, 0x81, 0xbf, 0x9c, 0x96, 0x10, 0x6d, 0x69, 0x8f, 0xb4, 0xcc, 0x24, 0x85, 0xa0, 0x3c, 0xbf, 0x43, 0xe2, 0x3b, 0x6e, 0xfc, 0x35, 0x5a, 0x4e, 0x1b 2016-11-09 22:16:03.190 Detail, Node002, Decrypted Packet: 0x00, 0x86, 0x14, 0x71, 0x01 2016-11-09 22:16:03.207 Detail, 2016-11-09 22:16:03.211 Info, Node002, Response RTT 260 Average Response RTT 356 2016-11-09 22:16:03.216 Info, Node002, Received Command Class Version report from node 2: CommandClass=COMMAND_CLASS_ALARM, Version=1 2016-11-09 22:16:03.220 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:03.220 Detail, Node002, Message transaction complete 2016-11-09 22:16:03.220 Detail, 2016-11-09 22:16:03.220 Detail, Node002, Removing current message 2016-11-09 22:16:03.236 Detail, Node002, Query Stage Complete (Versions) 2016-11-09 22:16:03.236 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Instances live=1 2016-11-09 22:16:03.236 Detail, Node002, QueryStage_Instances 2016-11-09 22:16:03.251 Info, Node002, Essential node queries are complete 2016-11-09 22:16:03.251 Detail, Node002, QueryStage_Static 2016-11-09 22:16:03.251 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_DOOR_LOCK_LOGGING 2016-11-09 22:16:03.251 Detail, Node002, Queuing (Query) DoorLockLoggingCmd_RecordSupported_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x4c, 0x01, 0x25, 0x14, 0x99 2016-11-09 22:16:03.267 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_DOOR_LOCK 2016-11-09 22:16:03.267 Detail, Node002, Queuing (Query) DoorLockCmd_Configuration_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x62, 0x05, 0x25, 0x15, 0xb2 2016-11-09 22:16:03.267 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_USER_CODE 2016-11-09 22:16:03.282 Detail, Node002, Queuing (Query) UserNumberCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x63, 0x04, 0x25, 0x16, 0xb1 2016-11-09 22:16:03.282 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_ASSOCIATION 2016-11-09 22:16:03.282 Detail, Node002, Queuing (Query) AssociationCmd_GroupingsGet (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x85, 0x05, 0x25, 0x17, 0x57 2016-11-09 22:16:03.282 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_VERSION 2016-11-09 22:16:03.298 Detail, Node002, Queuing (Query) VersionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x86, 0x11, 0x25, 0x18, 0x4f 2016-11-09 22:16:03.298 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_TIME_PARAMETERS 2016-11-09 22:16:03.298 Detail, Node002, Queuing (Query) TimeParametersCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x8b, 0x02, 0x25, 0x19, 0x50 2016-11-09 22:16:03.314 Detail, Node002, Queuing (Query) Query Stage Complete (Static) 2016-11-09 22:16:03.320 Detail, Node002, Notification: EssentialNodeQueriesComplete 2016-11-09 22:16:03.320 Detail, 2016-11-09 22:16:03.336 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x14, Expected Reply=0x04) 2016-11-09 22:16:03.351 Info, Node002, Sending (Query) message (Callback ID=0x14, Expected Reply=0x04) - Nonce_Get(DoorLockLoggingCmd_RecordSupported_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:03.367 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.383 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.383 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:03.398 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:03.398 Info, Node002, Request RTT 46 Average Request RTT 100 2016-11-09 22:16:03.398 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x14, 0x3f, 0x78, 0xe4, 0xf8, 0x7d, 0xa3, 0x14, 0x7e 2016-11-09 22:16:03.414 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:03.418 Info, Node002, Sending (Query) message (Callback ID=0x1a, Expected Reply=0x04) - DoorLockLoggingCmd_RecordSupported_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x4c, 0x01, 0x25, 0x1a, 0x97 2016-11-09 22:16:03.420 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.436 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.452 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1a, 0x00, 0x00, 0x03, 0xf2 2016-11-09 22:16:03.452 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1a received (expected 0x1a) 2016-11-09 22:16:03.452 Info, Node002, Request RTT 100 Average Request RTT 100 2016-11-09 22:16:03.467 Detail, Expected callbackId was received 2016-11-09 22:16:03.467 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:03.483 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:03.483 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:03.483 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:03.499 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:03.499 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:03.499 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.517 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.521 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.521 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.521 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34, 0x05, 0x01, 0x4f: 2016-11-09 22:16:03.536 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.536 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.552 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:03.552 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:03.568 Info, Node002, Request RTT 216 Average Request RTT 158 2016-11-09 22:16:03.568 Detail, Node002, Received: 0x01, 0x1d, 0x00, 0x04, 0x00, 0x02, 0x17, 0x98, 0x81, 0xc1, 0x25, 0xc4, 0xf3, 0x04, 0xfc, 0x48, 0x67, 0x24, 0xa4, 0x0e, 0x75, 0x26, 0x4f, 0xff, 0x3a, 0x2a, 0x56, 0x5a, 0xbe, 0xb4, 0x95 2016-11-09 22:16:03.583 Info, Raw: 0x98, 0x81, 0xc1, 0x25, 0xc4, 0xf3, 0x04, 0xfc, 0x48, 0x67, 0x24, 0xa4, 0x0e, 0x75, 0x26, 0x4f, 0xff, 0x3a, 0x2a, 0x56, 0x5a, 0xbe, 0xb4, 0x95 2016-11-09 22:16:03.599 Detail, Node002, Decrypted Packet: 0x00, 0x4c, 0x02, 0xff 2016-11-09 22:16:03.599 Detail, 2016-11-09 22:16:03.599 Info, Node002, Response RTT 247 Average Response RTT 301 2016-11-09 22:16:03.620 Info, Node002, Received DoorLockLoggingCmd_RecordSupported_Report: Max Records is 255 2016-11-09 22:16:03.621 Detail, Node002, Initial read of value 2016-11-09 22:16:03.621 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:03.621 Detail, Node002, Message transaction complete 2016-11-09 22:16:03.637 Detail, 2016-11-09 22:16:03.637 Detail, Node002, Removing current message 2016-11-09 22:16:03.637 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:03.637 Detail, 2016-11-09 22:16:03.652 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x15, Expected Reply=0x04) 2016-11-09 22:16:03.652 Info, Node002, Sending (Query) message (Callback ID=0x15, Expected Reply=0x04) - Nonce_Get(DoorLockCmd_Configuration_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:03.668 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.668 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.684 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:03.684 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:03.684 Info, Node002, Request RTT 31 Average Request RTT 94 2016-11-09 22:16:03.699 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xcf, 0xc5, 0xb9, 0x1c, 0x16, 0x50, 0x9f, 0x3d, 0xb0 2016-11-09 22:16:03.699 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:03.699 Info, Node002, Sending (Query) message (Callback ID=0x1b, Expected Reply=0x04) - DoorLockCmd_Configuration_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x62, 0x05, 0x25, 0x1b, 0xbc 2016-11-09 22:16:03.721 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.721 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.737 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1b, 0x00, 0x00, 0x02, 0xf2 2016-11-09 22:16:03.752 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1b received (expected 0x1b) 2016-11-09 22:16:03.752 Info, Node002, Request RTT 99 Average Request RTT 96 2016-11-09 22:16:03.752 Detail, Expected callbackId was received 2016-11-09 22:16:03.768 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:03.768 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:03.768 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:03.783 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:03.783 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:03.783 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:03.799 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:03.799 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.799 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.818 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:03.821 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd, 0x05, 0x01, 0x8e: 2016-11-09 22:16:03.821 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.837 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.853 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:03.853 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:03.853 Info, Node002, Request RTT 200 Average Request RTT 148 2016-11-09 22:16:03.868 Detail, Node002, Received: 0x01, 0x20, 0x00, 0x04, 0x00, 0x02, 0x1a, 0x98, 0x81, 0x68, 0xff, 0xb7, 0x2b, 0x66, 0xee, 0x69, 0x56, 0x3a, 0xce, 0x67, 0x73, 0xf7, 0x7a, 0x72, 0xed, 0x6b, 0x83, 0x05, 0x99, 0x16, 0xc0, 0x6f, 0x3e, 0x67 2016-11-09 22:16:03.868 Info, Raw: 0x98, 0x81, 0x68, 0xff, 0xb7, 0x2b, 0x66, 0xee, 0x69, 0x56, 0x3a, 0xce, 0x67, 0x73, 0xf7, 0x7a, 0x72, 0xed, 0x6b, 0x83, 0x05, 0x99, 0x16, 0xc0, 0x6f, 0x3e, 0x67 2016-11-09 22:16:03.884 Detail, Node002, Decrypted Packet: 0x00, 0x62, 0x06, 0x01, 0x00, 0xfe, 0x1e 2016-11-09 22:16:03.884 Detail, 2016-11-09 22:16:03.884 Info, Node002, Response RTT 231 Average Response RTT 266 2016-11-09 22:16:03.899 Detail, Node002, Initial read of value 2016-11-09 22:16:03.899 Detail, Node002, Initial read of value 2016-11-09 22:16:03.899 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:03.916 Detail, Node002, Message transaction complete 2016-11-09 22:16:03.920 Detail, 2016-11-09 22:16:03.922 Detail, Node002, Removing current message 2016-11-09 22:16:03.926 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:03.934 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:03.938 Detail, 2016-11-09 22:16:03.942 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x16, Expected Reply=0x04) 2016-11-09 22:16:03.946 Info, Node002, Sending (Query) message (Callback ID=0x16, Expected Reply=0x04) - Nonce_Get(UserNumberCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:03.946 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:03.961 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:03.961 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:03.977 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:03.977 Info, Node002, Request RTT 31 Average Request RTT 89 2016-11-09 22:16:03.977 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xbf, 0x5a, 0x40, 0xab, 0xa1, 0x97, 0xfa, 0x82, 0xbb 2016-11-09 22:16:03.993 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:03.993 Info, Node002, Sending (Query) message (Callback ID=0x1c, Expected Reply=0x04) - UserNumberCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x63, 0x04, 0x25, 0x1c, 0xbb 2016-11-09 22:16:04.016 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:04.021 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:04.037 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1c, 0x00, 0x00, 0x02, 0xf5 2016-11-09 22:16:04.037 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1c received (expected 0x1c) 2016-11-09 22:16:04.037 Info, Node002, Request RTT 91 Average Request RTT 90 2016-11-09 22:16:04.053 Detail, Expected callbackId was received 2016-11-09 22:16:04.069 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:04.084 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:04.100 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:04.100 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:04.100 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:04.118 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:04.122 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:04.122 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:04.122 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:04.138 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:04.138 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e, 0x05, 0x01, 0x62: 2016-11-09 22:16:04.153 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:04.153 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:04.169 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:04.169 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:04.184 Info, Node002, Request RTT 238 Average Request RTT 164 2016-11-09 22:16:04.184 Detail, Node002, Received: 0x01, 0x1d, 0x00, 0x04, 0x00, 0x02, 0x17, 0x98, 0x81, 0x7a, 0x59, 0x77, 0xee, 0xcf, 0xc9, 0xba, 0x59, 0x36, 0x03, 0xa0, 0xae, 0x90, 0x29, 0xe1, 0x1d, 0x5a, 0x64, 0x29, 0x76, 0x11, 0xbb 2016-11-09 22:16:04.200 Info, Raw: 0x98, 0x81, 0x7a, 0x59, 0x77, 0xee, 0xcf, 0xc9, 0xba, 0x59, 0x36, 0x03, 0xa0, 0xae, 0x90, 0x29, 0xe1, 0x1d, 0x5a, 0x64, 0x29, 0x76, 0x11, 0xbb 2016-11-09 22:16:04.200 Detail, Node002, Decrypted Packet: 0x00, 0x63, 0x05, 0xfa 2016-11-09 22:16:04.200 Detail, 2016-11-09 22:16:04.217 Info, Node002, Response RTT 271 Average Response RTT 268 2016-11-09 22:16:04.222 Info, Node002, Received User Number report from node 2: Supported Codes 250 (250) 2016-11-09 22:16:04.222 Detail, Node002, Initial read of value 2016-11-09 22:16:04.222 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:04.222 Detail, Node002, Message transaction complete 2016-11-09 22:16:04.238 Detail, 2016-11-09 22:16:04.238 Detail, Node002, Removing current message 2016-11-09 22:16:04.238 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:04.254 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.254 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.254 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.254 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.269 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.269 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.269 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.285 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.285 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.285 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.300 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.300 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.300 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.323 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.323 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.323 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.338 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.338 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.338 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.354 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.354 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.354 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.369 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.369 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.369 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.385 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.385 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.385 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.401 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.401 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.401 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.418 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.423 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.438 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.438 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.438 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.454 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.454 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.454 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.470 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.470 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.470 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.485 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.485 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.501 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.501 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.501 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.519 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.523 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.523 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.523 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.523 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.539 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.539 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.539 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.554 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.554 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.554 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.570 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.570 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.570 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.586 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.586 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.601 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.601 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.620 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.623 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.623 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.623 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.639 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.639 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.639 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.655 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.655 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.655 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.670 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.670 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.670 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.686 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.686 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.686 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.701 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.701 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.701 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.719 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.724 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.724 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.724 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.724 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.739 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.739 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.739 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.755 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.755 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.755 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.770 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.770 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.770 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.786 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.786 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.786 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.802 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.802 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.802 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.819 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.824 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.824 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.824 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.824 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.840 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.840 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.840 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.855 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.855 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.855 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.871 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.871 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.871 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.886 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.886 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.886 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.902 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.902 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.902 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.902 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.923 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.924 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.924 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.924 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.940 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.940 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.940 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.955 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.955 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.955 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:04.987 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.002 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.002 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.002 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.002 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.023 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.024 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.024 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.024 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.040 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.040 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.040 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.056 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.056 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.056 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.071 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.071 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.071 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.087 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.103 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.103 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.103 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.121 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.125 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.125 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.125 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.125 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.140 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.140 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.140 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.156 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.156 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.156 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.172 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.172 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.172 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.187 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.187 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.187 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.203 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.203 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.203 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.221 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.225 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.225 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.225 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.225 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.241 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.241 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.241 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.256 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.256 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.256 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.272 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.272 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.272 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.287 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.287 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.287 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.303 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.303 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.303 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.321 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.325 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.325 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.325 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.325 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.341 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.341 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.341 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.356 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.356 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.356 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.372 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.372 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.372 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.388 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.388 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.388 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.403 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.403 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.403 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.422 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.425 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.425 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.425 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.425 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.441 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.441 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.441 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.457 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.457 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.457 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.472 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.472 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.472 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.488 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.488 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.504 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.504 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.504 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.525 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.526 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.526 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.526 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.541 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.541 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.541 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.557 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.557 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.557 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.573 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.573 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.573 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.588 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.588 Detail, Node002, Notification: ValueAdded 2016-11-09 22:16:05.588 Detail, 2016-11-09 22:16:05.604 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x17, Expected Reply=0x04) 2016-11-09 22:16:05.622 Info, Node002, Sending (Query) message (Callback ID=0x17, Expected Reply=0x04) - Nonce_Get(AssociationCmd_GroupingsGet) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:05.626 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:05.626 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:05.642 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:05.657 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:05.657 Info, Node002, Request RTT 31 Average Request RTT 97 2016-11-09 22:16:05.673 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x7c, 0x14, 0x9a, 0x85, 0xa1, 0x60, 0xeb, 0x0c, 0xaa 2016-11-09 22:16:05.673 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:05.673 Info, Node002, Sending (Query) message (Callback ID=0x1d, Expected Reply=0x04) - AssociationCmd_GroupingsGet (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x85, 0x05, 0x25, 0x1d, 0x5d 2016-11-09 22:16:05.689 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:05.689 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:05.704 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1d, 0x00, 0x00, 0x02, 0xf4 2016-11-09 22:16:05.723 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1d received (expected 0x1d) 2016-11-09 22:16:05.726 Info, Node002, Request RTT 100 Average Request RTT 98 2016-11-09 22:16:05.726 Detail, Expected callbackId was received 2016-11-09 22:16:05.726 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:05.726 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:05.742 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:05.742 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:05.742 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:05.758 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:05.758 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:05.758 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:05.773 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:05.789 Info, NONCES: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00 2016-11-09 22:16:05.789 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e, 0x05, 0x01, 0x08: 2016-11-09 22:16:05.805 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:05.805 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:05.824 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:05.826 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:05.826 Info, Node002, Request RTT 200 Average Request RTT 149 2016-11-09 22:16:05.842 Detail, Node002, Received: 0x01, 0x1d, 0x00, 0x04, 0x00, 0x02, 0x17, 0x98, 0x81, 0xe7, 0xf2, 0xc7, 0xa2, 0xce, 0x08, 0x01, 0xdb, 0xbb, 0xdc, 0x56, 0x4f, 0xcc, 0x82, 0x19, 0x43, 0x3e, 0xcb, 0x7a, 0xe6, 0x6b, 0xee 2016-11-09 22:16:05.842 Info, Raw: 0x98, 0x81, 0xe7, 0xf2, 0xc7, 0xa2, 0xce, 0x08, 0x01, 0xdb, 0xbb, 0xdc, 0x56, 0x4f, 0xcc, 0x82, 0x19, 0x43, 0x3e, 0xcb, 0x7a, 0xe6, 0x6b, 0xee 2016-11-09 22:16:05.842 Detail, Node002, Decrypted Packet: 0x00, 0x85, 0x06, 0x01 2016-11-09 22:16:05.857 Detail, 2016-11-09 22:16:05.857 Info, Node002, Response RTT 231 Average Response RTT 249 2016-11-09 22:16:05.857 Info, Node002, Received Association Groupings report from node 2. Number of groups is 1 2016-11-09 22:16:05.873 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:05.873 Detail, Node002, Message transaction complete 2016-11-09 22:16:05.873 Detail, 2016-11-09 22:16:05.873 Detail, Node002, Removing current message 2016-11-09 22:16:05.889 Detail, 2016-11-09 22:16:05.889 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x18, Expected Reply=0x04) 2016-11-09 22:16:05.889 Info, Node002, Sending (Query) message (Callback ID=0x18, Expected Reply=0x04) - Nonce_Get(VersionCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:05.904 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:05.904 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:05.926 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x03, 0xea 2016-11-09 22:16:05.926 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:05.926 Info, Node002, Request RTT 21 Average Request RTT 85 2016-11-09 22:16:05.942 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x8a, 0x3c, 0xa2, 0xaf, 0xbc, 0x12, 0x55, 0x80, 0x3b 2016-11-09 22:16:05.942 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:05.957 Info, Node002, Sending (Query) message (Callback ID=0x1e, Expected Reply=0x04) - VersionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x86, 0x11, 0x25, 0x1e, 0x49 2016-11-09 22:16:05.973 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:05.973 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:05.989 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1e, 0x00, 0x00, 0x02, 0xf7 2016-11-09 22:16:06.004 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1e received (expected 0x1e) 2016-11-09 22:16:06.004 Info, Node002, Request RTT 99 Average Request RTT 92 2016-11-09 22:16:06.004 Detail, Expected callbackId was received 2016-11-09 22:16:06.024 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:06.026 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:06.026 Info, NONCES: 0x2a, 0x6c, 0xd7, 0xec, 0x2d, 0xaa, 0x04, 0x22 2016-11-09 22:16:06.026 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:06.042 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:06.042 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:06.042 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:06.058 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:06.058 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:06.058 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:06.073 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a, 0x05, 0x01, 0x86: 2016-11-09 22:16:06.073 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.089 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:06.105 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:06.105 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:06.126 Info, Node002, Request RTT 221 Average Request RTT 156 2016-11-09 22:16:06.127 Detail, Node002, Received: 0x01, 0x21, 0x00, 0x04, 0x00, 0x02, 0x1b, 0x98, 0x81, 0xa3, 0xdd, 0x92, 0x99, 0x8a, 0x00, 0x94, 0x8d, 0xb5, 0x62, 0xa9, 0xe5, 0x2b, 0xb2, 0x9a, 0xe6, 0x36, 0x0f, 0xe9, 0x55, 0x7c, 0xaa, 0xe9, 0x6e, 0xb9, 0x2f 2016-11-09 22:16:06.127 Info, Raw: 0x98, 0x81, 0xa3, 0xdd, 0x92, 0x99, 0x8a, 0x00, 0x94, 0x8d, 0xb5, 0x62, 0xa9, 0xe5, 0x2b, 0xb2, 0x9a, 0xe6, 0x36, 0x0f, 0xe9, 0x55, 0x7c, 0xaa, 0xe9, 0x6e, 0xb9, 0x2f 2016-11-09 22:16:06.142 Detail, Node002, Decrypted Packet: 0x00, 0x86, 0x12, 0x03, 0x03, 0x22, 0x21, 0x20 2016-11-09 22:16:06.142 Detail, 2016-11-09 22:16:06.142 Info, Node002, Response RTT 237 Average Response RTT 243 2016-11-09 22:16:06.158 Info, Node002, Received Version report from node 2: Library=3, Protocol=3.34, Application=33.32 2016-11-09 22:16:06.158 Detail, Node002, Initial read of value 2016-11-09 22:16:06.158 Detail, Node002, Initial read of value 2016-11-09 22:16:06.174 Detail, Node002, Initial read of value 2016-11-09 22:16:06.174 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:06.174 Detail, Node002, Message transaction complete 2016-11-09 22:16:06.189 Detail, 2016-11-09 22:16:06.189 Detail, Node002, Removing current message 2016-11-09 22:16:06.189 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:06.205 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:06.205 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:06.205 Detail, 2016-11-09 22:16:06.205 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x19, Expected Reply=0x04) 2016-11-09 22:16:06.225 Info, Node002, Sending (Query) message (Callback ID=0x19, Expected Reply=0x04) - Nonce_Get(TimeParametersCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:06.227 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.227 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:06.243 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:06.243 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:06.258 Info, Node002, Request RTT 31 Average Request RTT 93 2016-11-09 22:16:06.258 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xb0, 0x31, 0x4b, 0x45, 0xfa, 0xdc, 0x7f, 0x6d, 0x40 2016-11-09 22:16:06.258 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:06.274 Info, Node002, Sending (Query) message (Callback ID=0x1f, Expected Reply=0x04) - TimeParametersCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x8b, 0x02, 0x25, 0x1f, 0x56 2016-11-09 22:16:06.290 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.290 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:06.305 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x1f, 0x00, 0x00, 0x03, 0xf7 2016-11-09 22:16:06.305 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1f received (expected 0x1f) 2016-11-09 22:16:06.323 Info, Node002, Request RTT 95 Average Request RTT 94 2016-11-09 22:16:06.327 Detail, Expected callbackId was received 2016-11-09 22:16:06.327 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:06.327 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:06.343 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:06.343 Info, NONCES: 0xbc, 0xf0, 0x60, 0x60, 0x4d, 0xfd, 0x11, 0xed 2016-11-09 22:16:06.343 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:06.343 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:06.358 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:06.358 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:06.358 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:06.374 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:06.374 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b, 0x05, 0x01, 0x18: 2016-11-09 22:16:06.390 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.390 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:06.405 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:06.405 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:06.421 Info, Node002, Request RTT 194 Average Request RTT 144 2016-11-09 22:16:06.427 Detail, Node002, Received: 0x01, 0x23, 0x00, 0x04, 0x00, 0x02, 0x1d, 0x98, 0x81, 0x19, 0xda, 0xd9, 0x39, 0xa1, 0xee, 0xed, 0x5e, 0xb4, 0xa4, 0xdd, 0x8d, 0xbf, 0x3f, 0x21, 0x3e, 0x21, 0xf0, 0x22, 0x4f, 0x01, 0x0a, 0x2e, 0x90, 0x5a, 0xc0, 0xa1, 0xec 2016-11-09 22:16:06.427 Info, Raw: 0x98, 0x81, 0x19, 0xda, 0xd9, 0x39, 0xa1, 0xee, 0xed, 0x5e, 0xb4, 0xa4, 0xdd, 0x8d, 0xbf, 0x3f, 0x21, 0x3e, 0x21, 0xf0, 0x22, 0x4f, 0x01, 0x0a, 0x2e, 0x90, 0x5a, 0xc0, 0xa1, 0xec 2016-11-09 22:16:06.443 Detail, Node002, Decrypted Packet: 0x00, 0x8b, 0x03, 0x07, 0xd0, 0x01, 0x01, 0x00, 0x00, 0x00 2016-11-09 22:16:06.443 Detail, 2016-11-09 22:16:06.443 Info, Node002, Response RTT 215 Average Response RTT 229 2016-11-09 22:16:06.458 Info, Node002, Received TimeParameters report: 01/01/2000 00:00:00 2016-11-09 22:16:06.458 Detail, Node002, Initial read of value 2016-11-09 22:16:06.458 Detail, Node002, Initial read of value 2016-11-09 22:16:06.474 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:06.474 Detail, Node002, Message transaction complete 2016-11-09 22:16:06.490 Detail, 2016-11-09 22:16:06.490 Detail, Node002, Removing current message 2016-11-09 22:16:06.490 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:06.505 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:06.505 Detail, Node002, Query Stage Complete (Static) 2016-11-09 22:16:06.505 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1 2016-11-09 22:16:06.524 Detail, Node002, QueryStage_Associations 2016-11-09 22:16:06.528 Info, Node002, Number of association groups reported for node 2 is 1. 2016-11-09 22:16:06.528 Info, Node002, Get Associations for group 1 of node 2 2016-11-09 22:16:06.528 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_ASSOCIATION 2016-11-09 22:16:06.528 Detail, Node002, Queuing (Send) AssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x85, 0x02, 0x01, 0x25, 0x20, 0x64 2016-11-09 22:16:06.544 Detail, Node002, Queuing (Query) Query Stage Complete (Associations) 2016-11-09 22:16:06.544 Detail, 2016-11-09 22:16:06.544 Info, Node002, Processing (Send) Nonce Request message (Callback ID=0x20, Expected Reply=0x04) 2016-11-09 22:16:06.559 Info, Node002, Sending (Send) message (Callback ID=0x20, Expected Reply=0x04) - Nonce_Get(AssociationCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:06.559 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.575 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:06.587 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:06.595 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:06.611 Info, Node002, Request RTT 51 Average Request RTT 97 2016-11-09 22:16:06.621 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x70, 0x86, 0xa3, 0xe0, 0x45, 0xe5, 0x48, 0x91, 0x37 2016-11-09 22:16:06.626 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:06.628 Info, Node002, Sending (Send) message (Callback ID=0x21, Expected Reply=0x04) - AssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x85, 0x02, 0x01, 0x25, 0x21, 0x65 2016-11-09 22:16:06.644 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:06.648 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:07.635 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:07.651 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:07.685 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x21, 0x00, 0x00, 0x03, 0xc9 2016-11-09 22:16:07.716 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x21 received (expected 0x21) 2016-11-09 22:16:07.732 Info, Node002, Request RTT 1172 Average Request RTT 634 2016-11-09 22:16:07.732 Detail, Expected callbackId was received 2016-11-09 22:16:07.747 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:07.747 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:07.767 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:07.769 Info, NONCES: 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea 2016-11-09 22:16:07.769 Info, NONCES: 0xbf, 0xd5, 0xee, 0x52, 0x07, 0x46, 0x4e, 0x9a 2016-11-09 22:16:07.769 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:07.785 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:07.789 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:07.797 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:07.801 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:07.801 Info, Node002, Sending (Send) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea, 0x05, 0x01, 0x10: 2016-11-09 22:16:07.817 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:07.817 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:07.833 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:07.833 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:07.833 Info, Node002, Request RTT 1273 Average Request RTT 953 2016-11-09 22:16:07.848 Detail, Node002, Received: 0x01, 0x1f, 0x00, 0x04, 0x00, 0x02, 0x19, 0x98, 0x81, 0xec, 0xae, 0x40, 0x57, 0x46, 0xc2, 0x68, 0xf7, 0x95, 0xb8, 0xfe, 0x0e, 0x4f, 0x13, 0x51, 0x9f, 0x6a, 0x1f, 0x20, 0xd4, 0x7a, 0xec, 0x27, 0xd7 2016-11-09 22:16:07.864 Info, Raw: 0x98, 0x81, 0xec, 0xae, 0x40, 0x57, 0x46, 0xc2, 0x68, 0xf7, 0x95, 0xb8, 0xfe, 0x0e, 0x4f, 0x13, 0x51, 0x9f, 0x6a, 0x1f, 0x20, 0xd4, 0x7a, 0xec, 0x27, 0xd7 2016-11-09 22:16:07.869 Detail, Node002, Decrypted Packet: 0x00, 0x85, 0x03, 0x01, 0x05, 0x00 2016-11-09 22:16:07.869 Detail, 2016-11-09 22:16:07.869 Info, Node002, Response RTT 1309 Average Response RTT 769 2016-11-09 22:16:07.885 Info, Node002, Received Association report from node 2, group 1, containing 0 associations 2016-11-09 22:16:07.885 Info, Node002, Querying associations for node 2 is complete. 2016-11-09 22:16:07.885 Info, Node002, Adding the controller to group 1 (Group 1) of node 2 2016-11-09 22:16:07.885 Info, Node002, Association::Set - Adding node 1 to group 1 of node 2 2016-11-09 22:16:07.901 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_ASSOCIATION 2016-11-09 22:16:07.901 Detail, Node002, Queuing (Send) AssociationCmd_Set (Node=2): 0x01, 0x0b, 0x00, 0x13, 0x02, 0x04, 0x85, 0x01, 0x01, 0x01, 0x25, 0x22, 0x62 2016-11-09 22:16:07.901 Info, Node002, Get Associations for group 1 of node 2 2016-11-09 22:16:07.916 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_ASSOCIATION 2016-11-09 22:16:07.916 Detail, Node002, Queuing (Send) AssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x85, 0x02, 0x01, 0x25, 0x23, 0x67 2016-11-09 22:16:07.916 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:07.916 Detail, Node002, Message transaction complete 2016-11-09 22:16:07.932 Detail, 2016-11-09 22:16:07.932 Detail, Node002, Removing current message 2016-11-09 22:16:07.932 Detail, Node002, Notification: Group 2016-11-09 22:16:07.947 Detail, 2016-11-09 22:16:07.947 Info, Node002, Processing (Send) Nonce Request message (Callback ID=0x22, Expected Reply=0x13) 2016-11-09 22:16:07.947 Info, Node002, Sending (Send) message (Callback ID=0x22, Expected Reply=0x13) - Nonce_Get(AssociationCmd_Set) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:07.968 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:07.969 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:07.985 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:07.985 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:07.985 Info, Node002, Request RTT 37 Average Request RTT 495 2016-11-09 22:16:07.985 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xe6, 0xcf, 0xae, 0x1e, 0x7f, 0x65, 0xd6, 0x17, 0xb9 2016-11-09 22:16:08.001 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:08.001 Info, Node002, Sending (Send) message (Callback ID=0x24, Expected Reply=0x13) - AssociationCmd_Set (Node=2): 0x01, 0x0b, 0x00, 0x13, 0x02, 0x04, 0x85, 0x01, 0x01, 0x01, 0x25, 0x24, 0x64 2016-11-09 22:16:08.016 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:08.016 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:08.032 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x24, 0x00, 0x00, 0x03, 0xcc 2016-11-09 22:16:08.048 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x24 received (expected 0x24) 2016-11-09 22:16:08.048 Info, Node002, Request RTT 100 Average Request RTT 297 2016-11-09 22:16:08.048 Detail, Expected callbackId was received 2016-11-09 22:16:08.066 Detail, Expected reply was received 2016-11-09 22:16:08.069 Detail, Message transaction complete 2016-11-09 22:16:08.069 Detail, 2016-11-09 22:16:08.069 Detail, Node002, Removing current message 2016-11-09 22:16:08.085 Detail, 2016-11-09 22:16:08.085 Info, Node002, Processing (Send) Nonce Request message (Callback ID=0x23, Expected Reply=0x04) 2016-11-09 22:16:08.085 Info, Node002, Sending (Send) message (Callback ID=0x23, Expected Reply=0x04) - Nonce_Get(AssociationCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:08.101 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:08.101 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:08.117 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:08.117 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:08.132 Info, Node002, Request RTT 46 Average Request RTT 171 2016-11-09 22:16:08.132 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x09, 0x1d, 0xca, 0x4e, 0x7d, 0x7b, 0x70, 0xe0, 0xfd 2016-11-09 22:16:08.132 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:08.148 Info, Node002, Sending (Send) message (Callback ID=0x25, Expected Reply=0x04) - AssociationCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x85, 0x02, 0x01, 0x25, 0x25, 0x61 2016-11-09 22:16:08.164 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:08.170 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:08.186 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x25, 0x00, 0x00, 0x03, 0xcd 2016-11-09 22:16:08.186 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x25 received (expected 0x25) 2016-11-09 22:16:08.186 Info, Node002, Request RTT 100 Average Request RTT 135 2016-11-09 22:16:08.186 Detail, Expected callbackId was received 2016-11-09 22:16:08.201 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:08.201 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:08.201 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:08.217 Info, NONCES: 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea 2016-11-09 22:16:08.217 Info, NONCES: 0xfa, 0x81, 0x73, 0x41, 0x8e, 0x6f, 0x7a, 0xed 2016-11-09 22:16:08.217 Info, NONCES: 0x26, 0x8f, 0x52, 0x66, 0x54, 0x06, 0x5d, 0x34 2016-11-09 22:16:08.232 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:08.232 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:08.232 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:08.232 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:08.248 Info, Node002, Sending (Send) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xfa, 0x81, 0x73, 0x41, 0x8e, 0x6f, 0x7a, 0xed, 0x05, 0x01, 0xd6: 2016-11-09 22:16:08.264 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:08.269 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:08.270 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:08.286 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:08.286 Info, Node002, Request RTT 200 Average Request RTT 167 2016-11-09 22:16:08.301 Detail, Node002, Received: 0x01, 0x20, 0x00, 0x04, 0x00, 0x02, 0x1a, 0x98, 0x81, 0x69, 0x6e, 0x5b, 0x48, 0xf1, 0x24, 0x1f, 0xd4, 0x75, 0x22, 0x1b, 0x47, 0x30, 0x2f, 0x76, 0xfa, 0x0d, 0xd7, 0x03, 0xe2, 0xc2, 0xc3, 0x8b, 0xc5, 0x3c 2016-11-09 22:16:08.301 Info, Raw: 0x98, 0x81, 0x69, 0x6e, 0x5b, 0x48, 0xf1, 0x24, 0x1f, 0xd4, 0x75, 0x22, 0x1b, 0x47, 0x30, 0x2f, 0x76, 0xfa, 0x0d, 0xd7, 0x03, 0xe2, 0xc2, 0xc3, 0x8b, 0xc5, 0x3c 2016-11-09 22:16:08.301 Detail, Node002, Decrypted Packet: 0x00, 0x85, 0x03, 0x01, 0x05, 0x00, 0x01 2016-11-09 22:16:08.317 Detail, 2016-11-09 22:16:08.317 Info, Node002, Response RTT 231 Average Response RTT 500 2016-11-09 22:16:08.317 Info, Node002, Received Association report from node 2, group 1, containing 1 associations 2016-11-09 22:16:08.332 Info, Node002, The group contains: 2016-11-09 22:16:08.332 Info, Node002, Node 1 2016-11-09 22:16:08.332 Detail, Node002, Queuing (Controller) Delete All Return Routes 2016-11-09 22:16:08.332 Detail, Node002, Queuing (Controller) Assign Return Route 2016-11-09 22:16:08.348 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:08.348 Detail, Node002, Message transaction complete 2016-11-09 22:16:08.348 Detail, 2016-11-09 22:16:08.366 Detail, Node002, Removing current message 2016-11-09 22:16:08.370 Detail, Node002, Notification: Group 2016-11-09 22:16:08.370 Info, Deleting all return routes from node 2 2016-11-09 22:16:08.370 Detail, Node002, Queuing (Command) ControllerCommand_DeleteAllReturnRoutess (Node=2): 0x01, 0x05, 0x00, 0x47, 0x02, 0x26, 0x99 2016-11-09 22:16:08.370 Detail, Notification: ControllerComand - Starting 2016-11-09 22:16:08.386 Detail, 2016-11-09 22:16:08.386 Info, Node002, Sending (Command) message (Callback ID=0x26, Expected Reply=0x47) - ControllerCommand_DeleteAllReturnRoutess (Node=2): 0x01, 0x05, 0x00, 0x47, 0x02, 0x26, 0x99 2016-11-09 22:16:08.402 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x47, 0x01, 0xbc 2016-11-09 22:16:08.402 Detail, 2016-11-09 22:16:08.402 Info, Node002, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE - command in progress 2016-11-09 22:16:08.417 Detail, Notification: ControllerCommand - InProgress 2016-11-09 22:16:08.486 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x47, 0x26, 0x00, 0x9b 2016-11-09 22:16:08.486 Detail, 2016-11-09 22:16:08.501 Info, Node002, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE for node 2 - SUCCESS 2016-11-09 22:16:08.501 Detail, Expected callbackId was received 2016-11-09 22:16:08.517 Detail, Expected reply was received 2016-11-09 22:16:08.533 Detail, Message transaction complete 2016-11-09 22:16:08.533 Detail, 2016-11-09 22:16:08.548 Detail, Node002, Removing current message 2016-11-09 22:16:08.566 Detail, Notification: ControllerCommand - Completed 2016-11-09 22:16:08.570 Info, Assigning return route from node 2 to node 1 2016-11-09 22:16:08.570 Detail, Node002, Queuing (Command) ControllerCommand_AssignReturnRoute (Node=2): 0x01, 0x06, 0x00, 0x46, 0x02, 0x01, 0x27, 0x9b 2016-11-09 22:16:08.586 Detail, Notification: ControllerComand - Starting 2016-11-09 22:16:08.586 Detail, 2016-11-09 22:16:08.586 Info, Node002, Sending (Command) message (Callback ID=0x27, Expected Reply=0x46) - ControllerCommand_AssignReturnRoute (Node=2): 0x01, 0x06, 0x00, 0x46, 0x02, 0x01, 0x27, 0x9b 2016-11-09 22:16:08.602 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x46, 0x01, 0xbd 2016-11-09 22:16:08.617 Detail, 2016-11-09 22:16:08.617 Info, Node002, Received reply to FUNC_ID_ZW_ASSIGN_RETURN_ROUTE - command in progress 2016-11-09 22:16:08.617 Detail, Notification: ControllerCommand - InProgress 2016-11-09 22:16:08.871 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x46, 0x27, 0x00, 0x9b 2016-11-09 22:16:08.933 Detail, 2016-11-09 22:16:08.949 Info, Node002, Received reply to FUNC_ID_ZW_ASSIGN_RETURN_ROUTE for node 2 - SUCCESS 2016-11-09 22:16:08.949 Detail, Expected callbackId was received 2016-11-09 22:16:08.971 Detail, Expected reply was received 2016-11-09 22:16:08.971 Detail, Message transaction complete 2016-11-09 22:16:08.971 Detail, 2016-11-09 22:16:08.987 Detail, Node002, Removing current message 2016-11-09 22:16:08.987 Detail, Notification: ControllerCommand - Completed 2016-11-09 22:16:08.987 Detail, Node002, Query Stage Complete (Associations) 2016-11-09 22:16:09.002 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Neighbors live=1 2016-11-09 22:16:09.002 Detail, Node002, QueryStage_Neighbors 2016-11-09 22:16:09.002 Detail, Requesting routing info (neighbor list) for Node 2 2016-11-09 22:16:09.002 Detail, Node002, Queuing (Command) Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79 2016-11-09 22:16:09.018 Detail, Node002, Queuing (Query) Query Stage Complete (Neighbors) 2016-11-09 22:16:09.018 Detail, 2016-11-09 22:16:09.018 Info, Node002, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79 2016-11-09 22:16:09.033 Detail, Node002, Received: 0x01, 0x20, 0x01, 0x80, 0x01, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x5f 2016-11-09 22:16:09.033 Detail, 2016-11-09 22:16:09.033 Info, Node002, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO 2016-11-09 22:16:09.049 Info, Node002, Neighbors of this node are: 2016-11-09 22:16:09.049 Info, Node002, Node 1 2016-11-09 22:16:09.049 Detail, Expected reply was received 2016-11-09 22:16:09.067 Detail, Message transaction complete 2016-11-09 22:16:09.071 Detail, 2016-11-09 22:16:09.071 Detail, Node002, Removing current message 2016-11-09 22:16:09.071 Detail, Node002, Query Stage Complete (Neighbors) 2016-11-09 22:16:09.071 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1 2016-11-09 22:16:09.087 Detail, Node002, QueryStage_Session 2016-11-09 22:16:09.087 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_USER_CODE 2016-11-09 22:16:09.087 Detail, Node002, Queuing (Query) UserCodeCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x63, 0x02, 0x01, 0x25, 0x28, 0x8a 2016-11-09 22:16:09.102 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_PROTECTION 2016-11-09 22:16:09.102 Detail, Node002, Queuing (Query) ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x29, 0x9e 2016-11-09 22:16:09.102 Detail, Node002, Queuing (Query) Query Stage Complete (Session) 2016-11-09 22:16:09.118 Detail, 2016-11-09 22:16:09.118 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x28, Expected Reply=0x04) 2016-11-09 22:16:09.134 Info, Node002, Sending (Query) message (Callback ID=0x28, Expected Reply=0x04) - Nonce_Get(UserCodeCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:09.134 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.149 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.149 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:09.169 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:09.171 Info, Node002, Request RTT 37 Average Request RTT 102 2016-11-09 22:16:09.171 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x88, 0xfb, 0xcc, 0xb3, 0x4c, 0x7a, 0x57, 0x36, 0xa0 2016-11-09 22:16:09.188 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:09.196 Info, Node002, Sending (Query) message (Callback ID=0x2a, Expected Reply=0x04) - UserCodeCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x63, 0x02, 0x01, 0x25, 0x2a, 0x88 2016-11-09 22:16:09.212 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.212 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.228 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x2a, 0x00, 0x00, 0x03, 0xc2 2016-11-09 22:16:09.228 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2a received (expected 0x2a) 2016-11-09 22:16:09.243 Info, Node002, Request RTT 109 Average Request RTT 105 2016-11-09 22:16:09.243 Detail, Expected callbackId was received 2016-11-09 22:16:09.271 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:09.287 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:09.302 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:09.302 Info, NONCES: 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea 2016-11-09 22:16:09.302 Info, NONCES: 0xfa, 0x81, 0x73, 0x41, 0x8e, 0x6f, 0x7a, 0xed 2016-11-09 22:16:09.318 Info, NONCES: 0xa2, 0x2c, 0x73, 0x37, 0x93, 0x68, 0xb7, 0x77 2016-11-09 22:16:09.318 Info, NONCES: 0xed, 0x40, 0x55, 0x17, 0xa8, 0x23, 0xce, 0xcd 2016-11-09 22:16:09.334 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:09.334 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:09.334 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:09.349 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0xa2, 0x2c, 0x73, 0x37, 0x93, 0x68, 0xb7, 0x77, 0x05, 0x01, 0x18: 2016-11-09 22:16:09.369 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.372 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.387 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:09.387 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:09.387 Info, Node002, Request RTT 253 Average Request RTT 179 2016-11-09 22:16:09.403 Detail, Node002, Received: 0x01, 0x24, 0x00, 0x04, 0x00, 0x02, 0x1e, 0x98, 0x81, 0x9d, 0xbe, 0x04, 0x03, 0x0a, 0x0b, 0x0c, 0xbe, 0x97, 0xd0, 0x68, 0xb3, 0xb6, 0xbd, 0xe5, 0xb8, 0x53, 0x6c, 0x8e, 0xa2, 0x87, 0x24, 0x27, 0x5d, 0x9a, 0xb0, 0x2f, 0x74, 0x3c 2016-11-09 22:16:09.403 Info, Raw: 0x98, 0x81, 0x9d, 0xbe, 0x04, 0x03, 0x0a, 0x0b, 0x0c, 0xbe, 0x97, 0xd0, 0x68, 0xb3, 0xb6, 0xbd, 0xe5, 0xb8, 0x53, 0x6c, 0x8e, 0xa2, 0x87, 0x24, 0x27, 0x5d, 0x9a, 0xb0, 0x2f, 0x74, 0x3c 2016-11-09 22:16:09.419 Detail, Node002, Decrypted Packet: 0x00, 0x63, 0x03, 0x01, 0x01, 0x37, 0x35, 0x30, 0x32, 0x32, 0x31 2016-11-09 22:16:09.419 Detail, 2016-11-09 22:16:09.419 Info, Node002, Response RTT 284 Average Response RTT 392 2016-11-09 22:16:09.434 Info, Node002, User Code Packet is 6 2016-11-09 22:16:09.434 Detail, Node002, Initial read of value 2016-11-09 22:16:09.434 Info, Node002, Received User Code Report from node 2 for User Code 1 (Occupied) 2016-11-09 22:16:09.450 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_USER_CODE 2016-11-09 22:16:09.450 Detail, Node002, Queuing (Query) UserCodeCmd_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x63, 0x02, 0x02, 0x25, 0x2b, 0x8a 2016-11-09 22:16:09.450 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:09.450 Detail, Node002, Message transaction complete 2016-11-09 22:16:09.469 Detail, 2016-11-09 22:16:09.472 Detail, Node002, Removing current message 2016-11-09 22:16:09.472 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:09.472 Detail, 2016-11-09 22:16:09.472 Info, Node002, Processing (Query) Nonce Request message (Callback ID=0x29, Expected Reply=0x04) 2016-11-09 22:16:09.488 Info, Node002, Sending (Query) message (Callback ID=0x29, Expected Reply=0x04) - Nonce_Get(ProtectionCmd_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:09.503 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.503 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.519 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:09.519 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:09.519 Info, Node002, Request RTT 31 Average Request RTT 105 2016-11-09 22:16:09.534 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0x91, 0x20, 0xe1, 0xf2, 0xfa, 0x58, 0x57, 0x6f, 0xc3 2016-11-09 22:16:09.534 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:09.534 Info, Node002, Sending (Query) message (Callback ID=0x2c, Expected Reply=0x04) - ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x2c, 0x9b 2016-11-09 22:16:09.550 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.566 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.572 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x2c, 0x00, 0x00, 0x03, 0xc4 2016-11-09 22:16:09.587 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2c received (expected 0x2c) 2016-11-09 22:16:09.587 Info, Node002, Request RTT 99 Average Request RTT 102 2016-11-09 22:16:09.587 Detail, Expected callbackId was received 2016-11-09 22:16:09.603 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:09.603 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:09.603 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:09.619 Info, NONCES: 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea 2016-11-09 22:16:09.619 Info, NONCES: 0xfa, 0x81, 0x73, 0x41, 0x8e, 0x6f, 0x7a, 0xed 2016-11-09 22:16:09.619 Info, NONCES: 0xa2, 0x2c, 0x73, 0x37, 0x93, 0x68, 0xb7, 0x77 2016-11-09 22:16:09.619 Info, NONCES: 0x36, 0x2b, 0xeb, 0xde, 0xf4, 0x06, 0x32, 0x4f 2016-11-09 22:16:09.634 Info, NONCES: 0x90, 0x61, 0xd5, 0xf4, 0x4f, 0x4b, 0x61, 0x3e 2016-11-09 22:16:09.634 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:09.634 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:09.650 Info, Node002, Sending (Query) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x36, 0x2b, 0xeb, 0xde, 0xf4, 0x06, 0x32, 0x4f, 0x05, 0x01, 0x4e: 2016-11-09 22:16:09.650 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.670 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.672 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x03, 0xe9 2016-11-09 22:16:09.688 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:09.688 Info, Node002, Request RTT 200 Average Request RTT 151 2016-11-09 22:16:09.703 Detail, Node002, Received: 0x01, 0x1e, 0x00, 0x04, 0x00, 0x02, 0x18, 0x98, 0x81, 0xba, 0xa9, 0x52, 0x34, 0x3e, 0x03, 0xf5, 0x28, 0xbd, 0x74, 0x28, 0x46, 0x8c, 0x36, 0xeb, 0xc0, 0xa0, 0xe8, 0x56, 0x00, 0x71, 0xcc, 0xe6 2016-11-09 22:16:09.703 Info, Raw: 0x98, 0x81, 0xba, 0xa9, 0x52, 0x34, 0x3e, 0x03, 0xf5, 0x28, 0xbd, 0x74, 0x28, 0x46, 0x8c, 0x36, 0xeb, 0xc0, 0xa0, 0xe8, 0x56, 0x00, 0x71, 0xcc, 0xe6 2016-11-09 22:16:09.719 Detail, Node002, Decrypted Packet: 0x00, 0x75, 0x03, 0x00, 0x00 2016-11-09 22:16:09.719 Detail, 2016-11-09 22:16:09.719 Info, Node002, Response RTT 231 Average Response RTT 311 2016-11-09 22:16:09.735 Info, Node002, Received a Protection report: Unprotected 2016-11-09 22:16:09.735 Detail, Node002, Initial read of value 2016-11-09 22:16:09.735 Detail, Node002, Expected reply and command class was received 2016-11-09 22:16:09.750 Detail, Node002, Message transaction complete 2016-11-09 22:16:09.750 Detail, 2016-11-09 22:16:09.750 Detail, Node002, Removing current message 2016-11-09 22:16:09.750 Detail, Node002, Notification: ValueChanged 2016-11-09 22:16:09.770 Detail, Node002, Query Stage Complete (Session) 2016-11-09 22:16:09.772 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1 2016-11-09 22:16:09.772 Detail, Node002, QueryStage_Dynamic 2016-11-09 22:16:09.772 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_DOOR_LOCK_LOGGING 2016-11-09 22:16:09.788 Detail, Node002, Queuing (Send) DoorLockLoggingCmd_Record_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x02, 0x4c, 0x03, 0x00, 0x25, 0x2d, 0xa1 2016-11-09 22:16:09.788 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_DOOR_LOCK 2016-11-09 22:16:09.788 Detail, Node002, Queuing (Send) DoorLockCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x62, 0x02, 0x25, 0x2e, 0x8e 2016-11-09 22:16:09.788 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_ALARM 2016-11-09 22:16:09.804 Detail, Node002, Queuing (Send) AlarmCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x71, 0x04, 0x25, 0x2f, 0x9a 2016-11-09 22:16:09.804 Detail, Node002, Setting Encryption Flag on Message For Command Class COMMAND_CLASS_BATTERY 2016-11-09 22:16:09.804 Detail, Node002, Queuing (Send) BatteryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x80, 0x02, 0x25, 0x30, 0x72 2016-11-09 22:16:09.819 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic) 2016-11-09 22:16:09.819 Detail, 2016-11-09 22:16:09.819 Info, Node002, Processing (Send) Nonce Request message (Callback ID=0x2d, Expected Reply=0x04) 2016-11-09 22:16:09.819 Info, Node002, Sending (Send) message (Callback ID=0x2d, Expected Reply=0x04) - Nonce_Get(DoorLockLoggingCmd_Record_Get) - 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x98, 0x40, 0x05, 0x02: 2016-11-09 22:16:09.835 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.835 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.850 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x02, 0x00, 0x00, 0x02, 0xeb 2016-11-09 22:16:09.867 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x02 received (expected 0x02) 2016-11-09 22:16:09.871 Info, Node002, Request RTT 36 Average Request RTT 93 2016-11-09 22:16:09.873 Detail, Node002, Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x02, 0x0a, 0x98, 0x80, 0xc7, 0x09, 0xbc, 0x4e, 0x38, 0x3c, 0xdc, 0x3c, 0x23 2016-11-09 22:16:09.873 Info, Node002, Received SecurityCmd_NonceReport from node 2 2016-11-09 22:16:09.873 Info, Node002, Sending (Send) message (Callback ID=0x31, Expected Reply=0x04) - DoorLockLoggingCmd_Record_Get (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x02, 0x4c, 0x03, 0x00, 0x25, 0x31, 0xbd 2016-11-09 22:16:09.904 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:09.904 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:09.920 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x31, 0x00, 0x00, 0x03, 0xd9 2016-11-09 22:16:09.920 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x31 received (expected 0x31) 2016-11-09 22:16:09.935 Info, Node002, Request RTT 100 Average Request RTT 96 2016-11-09 22:16:09.935 Detail, Expected callbackId was received 2016-11-09 22:16:09.935 Detail, Node002, Received: 0x01, 0x08, 0x00, 0x04, 0x00, 0x02, 0x02, 0x98, 0x40, 0x2b 2016-11-09 22:16:09.951 Info, Node002, Received SecurityCmd_NonceGet from node 2 2016-11-09 22:16:09.951 Info, NONCES: 0x22, 0x11, 0x74, 0x12, 0x8c, 0xd1, 0xa2, 0x5b 2016-11-09 22:16:09.951 Info, NONCES: 0x51, 0x64, 0x92, 0x33, 0xd9, 0xf7, 0xa9, 0xea 2016-11-09 22:16:09.967 Info, NONCES: 0xfa, 0x81, 0x73, 0x41, 0x8e, 0x6f, 0x7a, 0xed 2016-11-09 22:16:09.972 Info, NONCES: 0xa2, 0x2c, 0x73, 0x37, 0x93, 0x68, 0xb7, 0x77 2016-11-09 22:16:09.973 Info, NONCES: 0x36, 0x2b, 0xeb, 0xde, 0xf4, 0x06, 0x32, 0x4f 2016-11-09 22:16:09.973 Info, NONCES: 0x0a, 0xf1, 0xd0, 0x0c, 0x36, 0xca, 0xb1, 0xba 2016-11-09 22:16:09.973 Info, NONCES: 0xcc, 0xef, 0x30, 0x69, 0x17, 0x76, 0x94, 0x6e 2016-11-09 22:16:09.988 Info, NONCES: 0x36, 0x34, 0xf5, 0x0e, 0x4d, 0xe7, 0x06, 0x3a 2016-11-09 22:16:09.988 Info, Node002, Sending (Send) message (Callback ID=0x01, Expected Reply=0x04) - Nonce_Report - 0x01, 0x11, 0x00, 0x13, 0x02, 0x0a, 0x98, 0x80, 0x0a, 0xf1, 0xd0, 0x0c, 0x36, 0xca, 0xb1, 0xba, 0x05, 0x01, 0x39: 2016-11-09 22:16:10.004 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 2016-11-09 22:16:10.004 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack 2016-11-09 22:16:10.020 Detail, Node002, Received: 0x01, 0x07, 0x00, 0x13, 0x01, 0x00, 0x00, 0x02, 0xe8 2016-11-09 22:16:10.020 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x01 received (expected 0x01) 2016-11-09 22:16:10.035 Info, Node002, Request RTT 200 Average Request RTT 148 2016-11-09 22:16:10.051 Detail, Node002, Received: 0x01, 0x28, 0x00, 0x04, 0x00, 0x02, 0x22, 0x98, 0x81, 0xf9, 0x5c, 0x51, 0xdb, 0xb6, 0xa8, 0x76, 0x7a, 0x7c, 0x89, 0x38, 0xc6, 0x28, 0x37, 0x08, 0xf1, 0x03, 0x9c, 0xeb, 0xb4, 0x03, 0xf6, 0x8a, 0x0a, 0x87, 0xad, 0x89, 0x7a, 0x03, 0x90, 0x93, 0x17, 0x41 2016-11-09 22:16:10.051 Info, Raw: 0x98, 0x81, 0xf9, 0x5c, 0x51, 0xdb, 0xb6, 0xa8, 0x76, 0x7a, 0x7c, 0x89, 0x38, 0xc6, 0x28, 0x37, 0x08, 0xf1, 0x03, 0x9c, 0xeb, 0xb4, 0x03, 0xf6, 0x8a, 0x0a, 0x87, 0xad, 0x89, 0x7a, 0x03, 0x90, 0x93, 0x17, 0x41 2016-11-09 22:16:10.051 Detail, Node002, Decrypted Packet: 0x00, 0x4c, 0x04, 0xc3, 0x07, 0xd0, 0x01, 0x01, 0x20, 0x00, 0x00, 0x03, 0x00, 0x71, 0x70 2016-11-09 22:16:10.069 Detail, 2016-11-09 22:16:10.073 Info, Node002, Response RTT 238 Average Response RTT 274 2016-11-09 22:16:10.073 Info, Node002, Recieved a DoorLockLogging Record 195 which is "Locked via Lock Button" 2016-11-09 22:16:10.073 Detail, Node002, Initial read of value

sleep888 commented 8 years ago

it seems to be a windows platform only issue. I tried on RasberryPi, it worked great.

Fishwaldo commented 8 years ago

Please try the latest snapshots from http://old.openzwave.com/snapshots/ to see if the problem is still present. (if it is, please reopen this case)