2021-09-16 15:12:31.001 Always, OpenZwave Version 1.4.3469 Starting Up
2021-09-16 15:12:43.568 Info, Setting Up Provided Network Key for Secure Communications
2021-09-16 15:12:43.569 Info, mgr,     Added driver for controller /dev/ttyUSB0
2021-09-16 15:12:43.569 Info,   Opening controller /dev/ttyUSB0
2021-09-16 15:12:43.570 Info, Trying to open serial port /dev/ttyUSB0 (attempt 1)
2021-09-16 15:12:43.574 Info, Serial port /dev/ttyUSB0 opened (attempt 1)
2021-09-16 15:12:43.575 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2021-09-16 15:12:43.575 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2021-09-16 15:12:43.575 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2021-09-16 15:12:43.575 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2021-09-16 15:12:43.575 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2021-09-16 15:12:43.576 Detail, 
2021-09-16 15:12:43.576 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2021-09-16 15:12:43.580 Detail, contrlr,   Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x30, 0x35, 0x00, 0x01, 0x97
2021-09-16 15:12:43.580 Detail, 
2021-09-16 15:12:43.580 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2021-09-16 15:12:43.580 Info, contrlr,     Static Controller library, version Z-Wave 4.05
2021-09-16 15:12:43.580 Detail, Node045,   Expected reply was received
2021-09-16 15:12:43.580 Detail, Node045,   Message transaction complete
2021-09-16 15:12:43.580 Detail, 
2021-09-16 15:12:43.580 Detail, contrlr, Removing current message
2021-09-16 15:12:43.581 Detail, 
2021-09-16 15:12:43.581 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2021-09-16 15:12:43.590 Detail, contrlr,   Received: 0x01, 0x08, 0x01, 0x20, 0xf9, 0xbd, 0x36, 0x98, 0x01, 0x3d
2021-09-16 15:12:43.590 Detail, 
2021-09-16 15:12:43.590 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xf9bd3698.  Our node ID = 1
2021-09-16 15:12:43.590 Detail, Node189,   Expected reply was received
2021-09-16 15:12:43.590 Detail, Node189,   Message transaction complete
2021-09-16 15:12:43.590 Detail, 
2021-09-16 15:12:43.590 Detail, contrlr, Removing current message
2021-09-16 15:12:43.590 Detail, 
2021-09-16 15:12:43.590 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2021-09-16 15:12:43.593 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x05, 0x1c, 0xe3
2021-09-16 15:12:43.594 Detail, 
2021-09-16 15:12:43.594 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2021-09-16 15:12:43.594 Info, contrlr,     There is a SUC ID Server (SIS) in this network.
2021-09-16 15:12:43.594 Info, contrlr,     The PC controller is an inclusion static update controller (SUC) and was the original primary before the SIS was added.
2021-09-16 15:12:43.594 Detail, Node227,   Expected reply was received
2021-09-16 15:12:43.594 Detail, Node227,   Message transaction complete
2021-09-16 15:12:43.594 Detail, 
2021-09-16 15:12:43.594 Detail, contrlr, Removing current message
2021-09-16 15:12:43.594 Detail, 
2021-09-16 15:12:43.594 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2021-09-16 15:12:43.602 Detail, contrlr,   Received: 0x01, 0x2b, 0x01, 0x07, 0x04, 0x20, 0x00, 0x00, 0x00, 0x01, 0x00, 0x01, 0xfe, 0x81, 0xff, 0x88, 0xcf, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x80, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0x03
2021-09-16 15:12:43.602 Detail, 
2021-09-16 15:12:43.602 Info, contrlr,  Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2021-09-16 15:12:43.602 Info, contrlr,     Serial API Version:   4.32
2021-09-16 15:12:43.603 Info, contrlr,     Manufacturer ID:      0x0000
2021-09-16 15:12:43.603 Info, contrlr,     Product Type:         0x0001
2021-09-16 15:12:43.603 Info, contrlr,     Product ID:           0x0001
2021-09-16 15:12:43.603 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2021-09-16 15:12:43.603 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2021-09-16 15:12:43.603 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2021-09-16 15:12:43.604 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2021-09-16 15:12:43.604 Detail, Node032,   Expected reply was received
2021-09-16 15:12:43.604 Detail, Node032,   Message transaction complete
2021-09-16 15:12:43.604 Detail, 
2021-09-16 15:12:43.604 Detail, contrlr, Removing current message
2021-09-16 15:12:43.604 Detail, 
2021-09-16 15:12:43.604 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2021-09-16 15:12:43.607 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x56, 0x01, 0xad
2021-09-16 15:12:43.608 Detail, 
2021-09-16 15:12:43.608 Info, contrlr, Received reply to GET_SUC_NODE_ID.  Node ID = 1
2021-09-16 15:12:43.608 Detail, Node173,   Expected reply was received
2021-09-16 15:12:43.608 Detail, Node173,   Message transaction complete
2021-09-16 15:12:43.608 Detail, 
2021-09-16 15:12:43.608 Detail, contrlr, Removing current message
2021-09-16 15:12:43.608 Detail, 
2021-09-16 15:12:43.608 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2021-09-16 15:12:43.663 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0xdb, 0xa7, 0xa9, 0xfb, 0xc6, 0xb5, 0x6c, 0xe2, 0x53, 0x4d, 0xf7, 0x0e, 0x4d, 0x33, 0xb2, 0x03, 0xa8, 0x69, 0x03, 0x4b, 0x87, 0x9b, 0x2d, 0xff, 0xe1, 0x08, 0x03, 0x3d, 0x44, 0xb4, 0xa4, 0xb0, 0x69
2021-09-16 15:12:43.663 Detail, 
2021-09-16 15:12:43.663 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true
2021-09-16 15:12:43.663 Detail, Node032,   Expected reply was received
2021-09-16 15:12:43.664 Detail, Node032,   Message transaction complete
2021-09-16 15:12:43.664 Detail, 
2021-09-16 15:12:43.664 Detail, contrlr, Removing current message
2021-09-16 15:12:43.664 Detail, 
2021-09-16 15:12:43.664 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2021-09-16 15:12:43.721 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x02, 0x05, 0x08, 0x1d, 0x03, 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, 0xcf
2021-09-16 15:12:43.721 Detail, 
2021-09-16 15:12:43.721 Info, mgr,     Driver with Home ID of 0xf9bd3698 is now ready.
2021-09-16 15:12:43.721 Info, 
2021-09-16 15:12:43.725 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
2021-09-16 15:12:43.726 Info, contrlr,     Node 001 - Known
2021-09-16 15:12:43.726 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2021-09-16 15:12:43.726 Detail, Node001, QueryStage_CacheLoad
2021-09-16 15:12:43.726 Info, Node001, Node Identity Codes: 0000:0001:0001
2021-09-16 15:12:43.726 Detail, Node001, QueryStage_Associations
2021-09-16 15:12:43.726 Detail, Node001, QueryStage_Neighbors
2021-09-16 15:12:43.726 Detail, contrlr, Requesting routing info (neighbor list) for Node 1
2021-09-16 15:12:43.726 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2021-09-16 15:12:43.726 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
2021-09-16 15:12:43.726 Info, contrlr,     Node 002 - Known
2021-09-16 15:12:43.726 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2021-09-16 15:12:43.726 Detail, Node002, QueryStage_CacheLoad
2021-09-16 15:12:43.726 Info, Node002, Node Identity Codes: 014f:5250:3030
2021-09-16 15:12:43.726 Info, Node002, NoOperation::Set - Routing=true
2021-09-16 15:12:43.727 Detail, Node002, Queuing (NoOp) NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xca
2021-09-16 15:12:43.727 Detail, Node002, Queuing (Query) Query Stage Complete (CacheLoad)
2021-09-16 15:12:43.727 Detail, Node008,   Expected reply was received
2021-09-16 15:12:43.727 Detail, Node008,   Message transaction complete
2021-09-16 15:12:43.727 Detail, 
2021-09-16 15:12:43.727 Detail, contrlr, Removing current message
2021-09-16 15:12:43.727 Detail, Node001, Notification: DriverReady
2021-09-16 15:12:43.730 Detail, Node001, Notification: NodeAdded
2021-09-16 15:12:43.735 Detail, Node001, Notification: NodeProtocolInfo
2021-09-16 15:12:43.753 Detail, Node001, Notification: EssentialNodeQueriesComplete
2021-09-16 15:12:43.757 Detail, Node001, Notification: ValueAdded
2021-09-16 15:12:43.765 Detail, Node002, Notification: NodeAdded
2021-09-16 15:12:43.768 Detail, Node002, Notification: NodeProtocolInfo
2021-09-16 15:12:43.771 Detail, Node002, Notification: EssentialNodeQueriesComplete
2021-09-16 15:12:43.788 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.832 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.834 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.836 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.849 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.851 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.854 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.862 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.864 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.869 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.872 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.893 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.901 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.903 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.905 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.913 Detail, Node002, Notification: ValueAdded
2021-09-16 15:12:43.915 Detail, Node002, Notification: NodeNaming
2021-09-16 15:12:43.917 Detail, 
2021-09-16 15:12:43.917 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2021-09-16 15:12:43.921 Detail, contrlr,   Received: 0x01, 0x05, 0x01, 0x06, 0x64, 0x0f, 0x96
2021-09-16 15:12:43.921 Detail, 
2021-09-16 15:12:43.921 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
2021-09-16 15:12:43.921 Detail, Node015,   Expected reply was received
2021-09-16 15:12:43.921 Detail, Node015,   Message transaction complete
2021-09-16 15:12:43.921 Detail, 
2021-09-16 15:12:43.921 Detail, contrlr, Removing current message
2021-09-16 15:12:43.921 Detail, 
2021-09-16 15:12:43.922 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
2021-09-16 15:12:43.924 Detail, contrlr, Removing current message
2021-09-16 15:12:43.925 Detail, 
2021-09-16 15:12:43.925 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
2021-09-16 15:12:43.931 Detail, Node001,   Received: 0x01, 0x20, 0x01, 0x80, 0x02, 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, 0x5c
2021-09-16 15:12:43.931 Detail, 
2021-09-16 15:12:43.931 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2021-09-16 15:12:43.932 Info, Node001,     Neighbors of this node are:
2021-09-16 15:12:43.932 Info, Node001,     Node 2
2021-09-16 15:12:43.932 Detail,   Expected reply was received
2021-09-16 15:12:43.932 Detail,   Message transaction complete
2021-09-16 15:12:43.932 Detail, 
2021-09-16 15:12:43.932 Detail, Node001, Removing current message
2021-09-16 15:12:43.932 Detail, 
2021-09-16 15:12:43.932 Info, Node002, Sending (NoOp) message (Callback ID=0x0a, Expected Reply=0x13) - NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xca
2021-09-16 15:12:43.939 Detail, Node002,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-16 15:12:43.939 Detail, Node002,   ZW_SEND_DATA delivered to Z-Wave stack
2021-09-16 15:12:43.955 Detail, Node002,   Received: 0x01, 0x05, 0x00, 0x13, 0x0a, 0x00, 0xe3
2021-09-16 15:12:43.955 Detail, Node002,   ZW_SEND_DATA Request with callback ID 0x0a received (expected 0x0a)
2021-09-16 15:12:43.955 Info, Node002, Request RTT 23 Average Request RTT 23
2021-09-16 15:12:43.956 Detail,   Expected callbackId was received
2021-09-16 15:12:43.956 Detail,   Expected reply was received
2021-09-16 15:12:43.956 Detail,   Message transaction complete
2021-09-16 15:12:43.956 Detail, 
2021-09-16 15:12:43.956 Detail, Node002, Removing current message
2021-09-16 15:12:43.956 Detail, Node002, Notification: Notification - NoOperation
2021-09-16 15:12:43.994 Detail, Node001, Query Stage Complete (Neighbors)
2021-09-16 15:12:43.994 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2021-09-16 15:12:43.994 Detail, Node001, QueryStage_Session
2021-09-16 15:12:43.994 Detail, Node001, QueryStage_Dynamic
2021-09-16 15:12:43.994 Detail, Node001, QueryStage_Configuration
2021-09-16 15:12:43.994 Detail, Node001, QueryStage_Complete
2021-09-16 15:12:43.994 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2021-09-16 15:12:43.994 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
2021-09-16 15:12:43.994 Detail, Node001, Notification: NodeQueriesComplete
2021-09-16 15:12:44.008 Detail, Node002, Query Stage Complete (CacheLoad)
2021-09-16 15:12:44.008 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
2021-09-16 15:12:44.008 Detail, Node002, QueryStage_Associations
2021-09-16 15:12:44.008 Detail, Node002, QueryStage_Neighbors
2021-09-16 15:12:44.008 Detail, Requesting routing info (neighbor list) for Node 2
2021-09-16 15:12:44.009 Detail, Node002, Queuing (Command) Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2021-09-16 15:12:44.009 Detail, Node002, Queuing (Query) Query Stage Complete (Neighbors)
2021-09-16 15:12:44.009 Detail, 
2021-09-16 15:12:44.010 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
2021-09-16 15:12:44.018 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
2021-09-16 15:12:44.018 Detail, 
2021-09-16 15:12:44.018 Info, Node002, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2021-09-16 15:12:44.018 Info, Node002,     Neighbors of this node are:
2021-09-16 15:12:44.018 Info, Node002,     Node 1
2021-09-16 15:12:44.018 Detail,   Expected reply was received
2021-09-16 15:12:44.018 Detail,   Message transaction complete
2021-09-16 15:12:44.018 Detail, 
2021-09-16 15:12:44.018 Detail, Node002, Removing current message
2021-09-16 15:12:44.019 Detail, Node002, Query Stage Complete (Neighbors)
2021-09-16 15:12:44.019 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2021-09-16 15:12:44.019 Detail, Node002, QueryStage_Session
2021-09-16 15:12:44.019 Detail, Node002, Queuing (Query) SwitchAllCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x27, 0x02, 0x25, 0x0b, 0xee
2021-09-16 15:12:44.019 Detail, Node002, Queuing (Query) PowerlevelCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x73, 0x02, 0x25, 0x0c, 0xbd
2021-09-16 15:12:44.019 Detail, Node002, Queuing (Query) ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x0d, 0xba
2021-09-16 15:12:44.019 Detail, Node002, Queuing (Query) Query Stage Complete (Session)
2021-09-16 15:12:44.019 Detail, 
2021-09-16 15:12:44.019 Info, Node002, Sending (Query) message (Callback ID=0x0b, Expected Reply=0x04) - SwitchAllCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x27, 0x02, 0x25, 0x0b, 0xee
2021-09-16 15:12:44.026 Detail, Node002,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-16 15:12:44.026 Detail, Node002,   ZW_SEND_DATA delivered to Z-Wave stack
2021-09-16 15:12:44.042 Detail, Node002,   Received: 0x01, 0x05, 0x00, 0x13, 0x0b, 0x00, 0xe2
2021-09-16 15:12:44.042 Detail, Node002,   ZW_SEND_DATA Request with callback ID 0x0b received (expected 0x0b)
2021-09-16 15:12:44.043 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-16 15:12:44.043 Detail,   Expected callbackId was received
2021-09-16 15:12:44.051 Detail, Node002,   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x27, 0x03, 0xff, 0x28
2021-09-16 15:12:44.051 Detail, 
2021-09-16 15:12:44.051 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-16 15:12:44.051 Detail, Node002, Initial read of value
2021-09-16 15:12:44.051 Info, Node002, Received SwitchAll report from node 2: On and Off Enabled
2021-09-16 15:12:44.051 Detail, Node002,   Expected reply and command class was received
2021-09-16 15:12:44.052 Detail, Node002,   Message transaction complete
2021-09-16 15:12:44.052 Detail, 
2021-09-16 15:12:44.052 Detail, Node002, Removing current message
2021-09-16 15:12:44.052 Detail, Node002, Notification: ValueChanged
2021-09-16 15:12:44.066 Detail, 
2021-09-16 15:12:44.066 Info, Node002, Sending (Query) message (Callback ID=0x0c, Expected Reply=0x04) - PowerlevelCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x73, 0x02, 0x25, 0x0c, 0xbd
2021-09-16 15:12:44.074 Detail, Node002,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-16 15:12:44.074 Detail, Node002,   ZW_SEND_DATA delivered to Z-Wave stack
2021-09-16 15:12:44.089 Detail, Node002,   Received: 0x01, 0x05, 0x00, 0x13, 0x0c, 0x00, 0xe5
2021-09-16 15:12:44.089 Detail, Node002,   ZW_SEND_DATA Request with callback ID 0x0c received (expected 0x0c)
2021-09-16 15:12:44.089 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-16 15:12:44.089 Detail,   Expected callbackId was received
2021-09-16 15:12:44.098 Detail, Node002,   Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x02, 0x04, 0x73, 0x03, 0x00, 0x00, 0x87
2021-09-16 15:12:44.098 Detail, 
2021-09-16 15:12:44.098 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-16 15:12:44.098 Info, Node002, Received a PowerLevel report: PowerLevel=Normal, Timeout=0
2021-09-16 15:12:44.098 Detail, Node002, Initial read of value
2021-09-16 15:12:44.098 Detail, Node002, Initial read of value
2021-09-16 15:12:44.099 Detail, Node002,   Expected reply and command class was received
2021-09-16 15:12:44.099 Detail, Node002,   Message transaction complete
2021-09-16 15:12:44.099 Detail, 
2021-09-16 15:12:44.099 Detail, Node002, Removing current message
2021-09-16 15:12:44.099 Detail, Node002, Notification: ValueChanged
2021-09-16 15:12:44.121 Detail, Node002, Notification: ValueChanged
2021-09-16 15:12:44.125 Detail, 
2021-09-16 15:12:44.125 Info, Node002, Sending (Query) message (Callback ID=0x0d, Expected Reply=0x04) - ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x0d, 0xba
2021-09-16 15:12:44.132 Detail, Node002,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-16 15:12:44.132 Detail, Node002,   ZW_SEND_DATA delivered to Z-Wave stack
2021-09-16 15:12:44.148 Detail, Node002,   Received: 0x01, 0x05, 0x00, 0x13, 0x0d, 0x00, 0xe4
2021-09-16 15:12:44.148 Detail, Node002,   ZW_SEND_DATA Request with callback ID 0x0d received (expected 0x0d)
2021-09-16 15:12:44.148 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-16 15:12:44.149 Detail,   Expected callbackId was received
2021-09-16 15:12:44.157 Detail, Node002,   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x75, 0x03, 0x00, 0x85
2021-09-16 15:12:44.157 Detail, 
2021-09-16 15:12:44.157 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-16 15:12:44.157 Info, Node002, Received a Protection report: Unprotected
2021-09-16 15:12:44.157 Detail, Node002, Initial read of value
2021-09-16 15:12:44.158 Detail, Node002,   Expected reply and command class was received
2021-09-16 15:12:44.158 Detail, Node002,   Message transaction complete
2021-09-16 15:12:44.158 Detail, 
2021-09-16 15:12:44.158 Detail, Node002, Removing current message
2021-09-16 15:12:44.158 Detail, Node002, Notification: ValueChanged
2021-09-16 15:12:44.169 Detail, Node002, Query Stage Complete (Session)
2021-09-16 15:12:44.169 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
2021-09-16 15:12:44.169 Detail, Node002, QueryStage_Dynamic
2021-09-16 15:12:44.170 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x0e, 0xe9
2021-09-16 15:12:44.170 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic)
2021-09-16 15:12:44.170 Detail, 
2021-09-16 15:12:44.170 Info, Node002, Sending (Send) message (Callback ID=0x0e, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x0e, 0xe9
2021-09-16 15:12:44.177 Detail, Node002,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-16 15:12:44.177 Detail, Node002,   ZW_SEND_DATA delivered to Z-Wave stack
2021-09-16 15:12:44.192 Detail, Node002,   Received: 0x01, 0x05, 0x00, 0x13, 0x0e, 0x00, 0xe7
2021-09-16 15:12:44.193 Detail, Node002,   ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
2021-09-16 15:12:44.193 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-16 15:12:44.193 Detail,   Expected callbackId was received
2021-09-16 15:12:44.201 Detail, Node002,   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-16 15:12:44.201 Detail, 
2021-09-16 15:12:44.202 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-16 15:12:44.202 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-16 15:12:44.202 Detail, Node002, Initial read of value
2021-09-16 15:12:44.202 Detail, Node002,   Expected reply and command class was received
2021-09-16 15:12:44.202 Detail, Node002,   Message transaction complete
2021-09-16 15:12:44.202 Detail, 
2021-09-16 15:12:44.202 Detail, Node002, Removing current message
2021-09-16 15:12:44.202 Detail, Node002, Notification: ValueChanged
2021-09-16 15:12:44.207 Detail, Node002, Query Stage Complete (Dynamic)
2021-09-16 15:12:44.207 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Configuration live=1
2021-09-16 15:12:44.207 Detail, Node002, QueryStage_Configuration
2021-09-16 15:12:44.207 Detail, Node002, QueryStage_Complete
2021-09-16 15:12:44.207 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2021-09-16 15:12:44.208 Warning, CheckCompletedNodeQueries all=1, deadFound=0 sleepingOnly=1
2021-09-16 15:12:44.208 Info,          Node query processing complete.
2021-09-16 15:12:44.208 Detail, Node002, Notification: NodeQueriesComplete
2021-09-16 15:12:44.220 Detail, contrlr, Notification: AllNodesQueried
2021-09-16 16:48:44.778 Info, mgr,     Manager::WriteConfig completed for driver with home ID of 0xf9bd3698
2021-09-16 16:48:45.783 Info, mgr,     Driver for controller /dev/ttyUSB0 pending removal
2021-09-16 16:48:45.784 Detail, Notification: DriverRemoved
2021-09-16 16:48:45.784 Always, ***************************************************************************
2021-09-16 16:48:45.784 Always, *********************  Cumulative Network Statistics  *********************
2021-09-16 16:48:45.784 Always, *** General
2021-09-16 16:48:45.784 Always, Driver run time: . .  . 0 days, 1 hours, 36 minutes
2021-09-16 16:48:45.784 Always, Frames processed: . . . . . . . . . . . . . . . . . . . . 24
2021-09-16 16:48:45.784 Always, Total messages successfully received: . . . . . . . . . . 24
2021-09-16 16:48:45.784 Always, Total Messages successfully sent: . . . . . . . . . . . . 16
2021-09-16 16:48:45.784 Always, ACKs received from controller:  . . . . . . . . . . . . . 16
2021-09-16 16:48:45.784 Always, *** Errors
2021-09-16 16:48:45.784 Always, Unsolicited messages received while waiting for ACK:  . . 0
2021-09-16 16:48:45.784 Always, Reads aborted due to timeouts:  . . . . . . . . . . . . . 0
2021-09-16 16:48:45.784 Always, Bad checksum errors:  . . . . . . . . . . . . . . . . . . 0
2021-09-16 16:48:45.784 Always, CANs received from controller:  . . . . . . . . . . . . . 0
2021-09-16 16:48:45.785 Always, NAKs received from controller:  . . . . . . . . . . . . . 0
2021-09-16 16:48:45.785 Always, Out of frame data flow errors:  . . . . . . . . . . . . . 0
2021-09-16 16:48:45.785 Always, Messages retransmitted: . . . . . . . . . . . . . . . . . 0
2021-09-16 16:48:45.785 Always, Messages dropped and not delivered: . . . . . . . . . . . 0
2021-09-16 16:48:45.785 Always, ***************************************************************************
2021-09-16 16:48:47.796 Info, mgr,     Driver for controller /dev/ttyUSB0 removed
2021-09-16 16:48:48.800 Error, mgr,     Manager::GetDriver failed - Home ID 0xf9bd3698 is unknown
2021-09-16 16:48:48.800 Warning, Exception: Manager.cpp:373 - 100 - Invalid HomeId passed to GetDriver
2021-09-16 16:48:48.800 Info, mgr,     GetSendQueueCount() failed - _homeId -105040232 not found