update 9.14.21

This commit is contained in:
root
2021-09-14 23:33:09 -04:00
parent 4cf44009a2
commit f92b773514
13 changed files with 5071 additions and 0 deletions

916
OZW_Log.txt Normal file
View File

@@ -0,0 +1,916 @@
2021-09-06 20:50:44.304 Always, OpenZwave Version 1.4.3469 Starting Up
2021-09-06 20:51:08.917 Info, Setting Up Provided Network Key for Secure Communications
2021-09-06 20:51:08.918 Info, mgr, Added driver for controller /dev/ttyUSB0
2021-09-06 20:51:08.918 Info, Opening controller /dev/ttyUSB0
2021-09-06 20:51:08.919 Info, Trying to open serial port /dev/ttyUSB0 (attempt 1)
2021-09-06 20:51:08.922 Info, Serial port /dev/ttyUSB0 opened (attempt 1)
2021-09-06 20:51:08.923 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2021-09-06 20:51:08.923 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2021-09-06 20:51:08.923 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2021-09-06 20:51:08.923 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2021-09-06 20:51:08.924 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2021-09-06 20:51:08.924 Detail,
2021-09-06 20:51:08.924 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2021-09-06 20:51:08.928 Detail, contrlr, Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x30, 0x35, 0x00, 0x01, 0x97
2021-09-06 20:51:08.928 Detail,
2021-09-06 20:51:08.928 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2021-09-06 20:51:08.928 Info, contrlr, Static Controller library, version Z-Wave 4.05
2021-09-06 20:51:08.928 Detail, Node045, Expected reply was received
2021-09-06 20:51:08.928 Detail, Node045, Message transaction complete
2021-09-06 20:51:08.928 Detail,
2021-09-06 20:51:08.928 Detail, contrlr, Removing current message
2021-09-06 20:51:08.928 Detail,
2021-09-06 20:51:08.928 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2021-09-06 20:51:08.931 Detail, contrlr, Received: 0x01, 0x08, 0x01, 0x20, 0xf9, 0xbd, 0x36, 0x98, 0x01, 0x3d
2021-09-06 20:51:08.932 Detail,
2021-09-06 20:51:08.932 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xf9bd3698. Our node ID = 1
2021-09-06 20:51:08.932 Detail, Node189, Expected reply was received
2021-09-06 20:51:08.932 Detail, Node189, Message transaction complete
2021-09-06 20:51:08.932 Detail,
2021-09-06 20:51:08.932 Detail, contrlr, Removing current message
2021-09-06 20:51:08.932 Detail,
2021-09-06 20:51:08.932 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2021-09-06 20:51:08.934 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x05, 0x1c, 0xe3
2021-09-06 20:51:08.934 Detail,
2021-09-06 20:51:08.934 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2021-09-06 20:51:08.934 Info, contrlr, There is a SUC ID Server (SIS) in this network.
2021-09-06 20:51:08.934 Info, contrlr, The PC controller is an inclusion static update controller (SUC) and was the original primary before the SIS was added.
2021-09-06 20:51:08.935 Detail, Node227, Expected reply was received
2021-09-06 20:51:08.935 Detail, Node227, Message transaction complete
2021-09-06 20:51:08.935 Detail,
2021-09-06 20:51:08.935 Detail, contrlr, Removing current message
2021-09-06 20:51:08.935 Detail,
2021-09-06 20:51:08.935 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2021-09-06 20:51:08.944 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-06 20:51:08.944 Detail,
2021-09-06 20:51:08.944 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2021-09-06 20:51:08.944 Info, contrlr, Serial API Version: 4.32
2021-09-06 20:51:08.944 Info, contrlr, Manufacturer ID: 0x0000
2021-09-06 20:51:08.944 Info, contrlr, Product Type: 0x0001
2021-09-06 20:51:08.944 Info, contrlr, Product ID: 0x0001
2021-09-06 20:51:08.944 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2021-09-06 20:51:08.945 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2021-09-06 20:51:08.945 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2021-09-06 20:51:08.945 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2021-09-06 20:51:08.945 Detail, Node032, Expected reply was received
2021-09-06 20:51:08.945 Detail, Node032, Message transaction complete
2021-09-06 20:51:08.945 Detail,
2021-09-06 20:51:08.945 Detail, contrlr, Removing current message
2021-09-06 20:51:08.945 Detail,
2021-09-06 20:51:08.945 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-06 20:51:08.948 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x56, 0x01, 0xad
2021-09-06 20:51:08.948 Detail,
2021-09-06 20:51:08.949 Info, contrlr, Received reply to GET_SUC_NODE_ID. Node ID = 1
2021-09-06 20:51:08.949 Detail, Node173, Expected reply was received
2021-09-06 20:51:08.949 Detail, Node173, Message transaction complete
2021-09-06 20:51:08.949 Detail,
2021-09-06 20:51:08.949 Detail, contrlr, Removing current message
2021-09-06 20:51:08.949 Detail,
2021-09-06 20:51:08.949 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2021-09-06 20:51:09.004 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0x8c, 0xf8, 0xa3, 0xec, 0xf5, 0x9f, 0x7d, 0x01, 0xb4, 0x2d, 0x86, 0xb7, 0x62, 0xf6, 0x75, 0x5a, 0x9b, 0xd8, 0x0e, 0xab, 0xa9, 0xae, 0x7a, 0xf6, 0xc3, 0xc2, 0xd1, 0x9a, 0xa9, 0xf6, 0x79, 0xa7, 0x7e
2021-09-06 20:51:09.004 Detail,
2021-09-06 20:51:09.004 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true
2021-09-06 20:51:09.004 Detail, Node032, Expected reply was received
2021-09-06 20:51:09.004 Detail, Node032, Message transaction complete
2021-09-06 20:51:09.005 Detail,
2021-09-06 20:51:09.005 Detail, contrlr, Removing current message
2021-09-06 20:51:09.005 Detail,
2021-09-06 20:51:09.005 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-06 20:51:09.062 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-06 20:51:09.062 Detail,
2021-09-06 20:51:09.062 Info, mgr, Driver with Home ID of 0xf9bd3698 is now ready.
2021-09-06 20:51:09.062 Info,
2021-09-06 20:51:09.071 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
2021-09-06 20:51:09.071 Info, contrlr, Node 001 - Known
2021-09-06 20:51:09.071 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2021-09-06 20:51:09.071 Detail, Node001, QueryStage_CacheLoad
2021-09-06 20:51:09.071 Info, Node001, Node Identity Codes: 0000:0001:0001
2021-09-06 20:51:09.071 Detail, Node001, QueryStage_Associations
2021-09-06 20:51:09.071 Detail, Node001, QueryStage_Neighbors
2021-09-06 20:51:09.071 Detail, contrlr, Requesting routing info (neighbor list) for Node 1
2021-09-06 20:51:09.071 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2021-09-06 20:51:09.071 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
2021-09-06 20:51:09.072 Info, contrlr, Node 002 - Known
2021-09-06 20:51:09.072 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2021-09-06 20:51:09.072 Detail, Node002, QueryStage_CacheLoad
2021-09-06 20:51:09.072 Info, Node002, Node Identity Codes: 014f:5250:3030
2021-09-06 20:51:09.072 Info, Node002, NoOperation::Set - Routing=true
2021-09-06 20:51:09.072 Detail, Node002, Queuing (NoOp) NoOperation_Set (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xca
2021-09-06 20:51:09.072 Detail, Node002, Queuing (Query) Query Stage Complete (CacheLoad)
2021-09-06 20:51:09.072 Detail, Node008, Expected reply was received
2021-09-06 20:51:09.072 Detail, Node008, Message transaction complete
2021-09-06 20:51:09.073 Detail,
2021-09-06 20:51:09.073 Detail, contrlr, Removing current message
2021-09-06 20:51:09.073 Detail, Node001, Notification: DriverReady
2021-09-06 20:51:09.075 Detail, Node001, Notification: NodeAdded
2021-09-06 20:51:09.081 Detail, Node001, Notification: NodeProtocolInfo
2021-09-06 20:51:09.084 Detail, Node001, Notification: EssentialNodeQueriesComplete
2021-09-06 20:51:09.085 Detail, Node001, Notification: ValueAdded
2021-09-06 20:51:09.087 Detail, Node002, Notification: NodeAdded
2021-09-06 20:51:09.092 Detail, Node002, Notification: NodeProtocolInfo
2021-09-06 20:51:09.095 Detail, Node002, Notification: EssentialNodeQueriesComplete
2021-09-06 20:51:09.096 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.104 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.107 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.109 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.111 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.113 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.115 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.118 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.126 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.133 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.153 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.163 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.172 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.180 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.193 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.201 Detail, Node002, Notification: ValueAdded
2021-09-06 20:51:09.210 Detail, Node002, Notification: NodeNaming
2021-09-06 20:51:09.234 Detail,
2021-09-06 20:51:09.234 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-06 20:51:09.237 Detail, contrlr, Received: 0x01, 0x05, 0x01, 0x06, 0x64, 0x0f, 0x96
2021-09-06 20:51:09.237 Detail,
2021-09-06 20:51:09.237 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
2021-09-06 20:51:09.237 Detail, Node015, Expected reply was received
2021-09-06 20:51:09.237 Detail, Node015, Message transaction complete
2021-09-06 20:51:09.237 Detail,
2021-09-06 20:51:09.237 Detail, contrlr, Removing current message
2021-09-06 20:51:09.238 Detail,
2021-09-06 20:51:09.238 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-06 20:51:09.240 Detail, contrlr, Removing current message
2021-09-06 20:51:09.240 Detail,
2021-09-06 20:51:09.241 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-06 20:51:09.247 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-06 20:51:09.248 Detail,
2021-09-06 20:51:09.248 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2021-09-06 20:51:09.248 Info, Node001, Neighbors of this node are:
2021-09-06 20:51:09.248 Info, Node001, Node 2
2021-09-06 20:51:09.248 Detail, Expected reply was received
2021-09-06 20:51:09.248 Detail, Message transaction complete
2021-09-06 20:51:09.248 Detail,
2021-09-06 20:51:09.248 Detail, Node001, Removing current message
2021-09-06 20:51:09.249 Detail,
2021-09-06 20:51:09.249 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-06 20:51:09.256 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-06 20:51:09.257 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-06 20:51:09.271 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0a, 0x00, 0xe3
2021-09-06 20:51:09.271 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0a received (expected 0x0a)
2021-09-06 20:51:09.272 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-06 20:51:09.272 Detail, Expected callbackId was received
2021-09-06 20:51:09.272 Detail, Expected reply was received
2021-09-06 20:51:09.272 Detail, Message transaction complete
2021-09-06 20:51:09.272 Detail,
2021-09-06 20:51:09.272 Detail, Node002, Removing current message
2021-09-06 20:51:09.273 Detail, Node002, Notification: Notification - NoOperation
2021-09-06 20:51:09.278 Detail, Node001, Query Stage Complete (Neighbors)
2021-09-06 20:51:09.278 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2021-09-06 20:51:09.278 Detail, Node001, QueryStage_Session
2021-09-06 20:51:09.278 Detail, Node001, QueryStage_Dynamic
2021-09-06 20:51:09.279 Detail, Node001, QueryStage_Configuration
2021-09-06 20:51:09.279 Detail, Node001, QueryStage_Complete
2021-09-06 20:51:09.279 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2021-09-06 20:51:09.279 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=0
2021-09-06 20:51:09.279 Detail, Node001, Notification: NodeQueriesComplete
2021-09-06 20:51:09.288 Detail, Node002, Query Stage Complete (CacheLoad)
2021-09-06 20:51:09.288 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
2021-09-06 20:51:09.288 Detail, Node002, QueryStage_Associations
2021-09-06 20:51:09.288 Detail, Node002, QueryStage_Neighbors
2021-09-06 20:51:09.288 Detail, Requesting routing info (neighbor list) for Node 2
2021-09-06 20:51:09.288 Detail, Node002, Queuing (Command) Get Routing Info (Node=2): 0x01, 0x07, 0x00, 0x80, 0x02, 0x00, 0x00, 0x03, 0x79
2021-09-06 20:51:09.288 Detail, Node002, Queuing (Query) Query Stage Complete (Neighbors)
2021-09-06 20:51:09.288 Detail,
2021-09-06 20:51:09.289 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-06 20:51:09.296 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-06 20:51:09.296 Detail,
2021-09-06 20:51:09.296 Info, Node002, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2021-09-06 20:51:09.296 Info, Node002, Neighbors of this node are:
2021-09-06 20:51:09.297 Info, Node002, Node 1
2021-09-06 20:51:09.297 Detail, Expected reply was received
2021-09-06 20:51:09.297 Detail, Message transaction complete
2021-09-06 20:51:09.297 Detail,
2021-09-06 20:51:09.297 Detail, Node002, Removing current message
2021-09-06 20:51:09.297 Detail, Node002, Query Stage Complete (Neighbors)
2021-09-06 20:51:09.297 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2021-09-06 20:51:09.297 Detail, Node002, QueryStage_Session
2021-09-06 20:51:09.297 Detail, Node002, Queuing (Query) SwitchAllCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x27, 0x02, 0x25, 0x0b, 0xee
2021-09-06 20:51:09.297 Detail, Node002, Queuing (Query) PowerlevelCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x73, 0x02, 0x25, 0x0c, 0xbd
2021-09-06 20:51:09.298 Detail, Node002, Queuing (Query) ProtectionCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x75, 0x02, 0x25, 0x0d, 0xba
2021-09-06 20:51:09.298 Detail, Node002, Queuing (Query) Query Stage Complete (Session)
2021-09-06 20:51:09.298 Detail,
2021-09-06 20:51:09.298 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-06 20:51:09.305 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-06 20:51:09.306 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-06 20:51:09.321 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0b, 0x00, 0xe2
2021-09-06 20:51:09.321 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0b received (expected 0x0b)
2021-09-06 20:51:09.321 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-06 20:51:09.321 Detail, Expected callbackId was received
2021-09-06 20:51:09.329 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x27, 0x03, 0xff, 0x28
2021-09-06 20:51:09.330 Detail,
2021-09-06 20:51:09.330 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-06 20:51:09.330 Detail, Node002, Initial read of value
2021-09-06 20:51:09.330 Info, Node002, Received SwitchAll report from node 2: On and Off Enabled
2021-09-06 20:51:09.330 Detail, Node002, Expected reply and command class was received
2021-09-06 20:51:09.330 Detail, Node002, Message transaction complete
2021-09-06 20:51:09.330 Detail,
2021-09-06 20:51:09.330 Detail, Node002, Removing current message
2021-09-06 20:51:09.330 Detail, Node002, Notification: ValueChanged
2021-09-06 20:51:09.341 Detail,
2021-09-06 20:51:09.341 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-06 20:51:09.348 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-06 20:51:09.349 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-06 20:51:09.364 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0c, 0x00, 0xe5
2021-09-06 20:51:09.364 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0c received (expected 0x0c)
2021-09-06 20:51:09.364 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-06 20:51:09.364 Detail, Expected callbackId was received
2021-09-06 20:51:09.374 Detail, Node002, Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x02, 0x04, 0x73, 0x03, 0x00, 0x00, 0x87
2021-09-06 20:51:09.374 Detail,
2021-09-06 20:51:09.374 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-06 20:51:09.374 Info, Node002, Received a PowerLevel report: PowerLevel=Normal, Timeout=0
2021-09-06 20:51:09.374 Detail, Node002, Initial read of value
2021-09-06 20:51:09.374 Detail, Node002, Initial read of value
2021-09-06 20:51:09.374 Detail, Node002, Expected reply and command class was received
2021-09-06 20:51:09.375 Detail, Node002, Message transaction complete
2021-09-06 20:51:09.375 Detail,
2021-09-06 20:51:09.375 Detail, Node002, Removing current message
2021-09-06 20:51:09.375 Detail, Node002, Notification: ValueChanged
2021-09-06 20:51:09.378 Detail, Node002, Notification: ValueChanged
2021-09-06 20:51:09.393 Detail,
2021-09-06 20:51:09.393 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-06 20:51:09.400 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-06 20:51:09.400 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-06 20:51:09.417 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0d, 0x00, 0xe4
2021-09-06 20:51:09.417 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0d received (expected 0x0d)
2021-09-06 20:51:09.417 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-06 20:51:09.417 Detail, Expected callbackId was received
2021-09-06 20:51:09.425 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x75, 0x03, 0x00, 0x85
2021-09-06 20:51:09.426 Detail,
2021-09-06 20:51:09.426 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-06 20:51:09.426 Info, Node002, Received a Protection report: Unprotected
2021-09-06 20:51:09.426 Detail, Node002, Initial read of value
2021-09-06 20:51:09.426 Detail, Node002, Expected reply and command class was received
2021-09-06 20:51:09.426 Detail, Node002, Message transaction complete
2021-09-06 20:51:09.426 Detail,
2021-09-06 20:51:09.426 Detail, Node002, Removing current message
2021-09-06 20:51:09.426 Detail, Node002, Notification: ValueChanged
2021-09-06 20:51:09.449 Detail, Node002, Query Stage Complete (Session)
2021-09-06 20:51:09.450 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
2021-09-06 20:51:09.450 Detail, Node002, QueryStage_Dynamic
2021-09-06 20:51:09.450 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x0e, 0xe9
2021-09-06 20:51:09.450 Detail, Node002, Queuing (Query) Query Stage Complete (Dynamic)
2021-09-06 20:51:09.450 Detail,
2021-09-06 20:51:09.451 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-06 20:51:09.457 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-06 20:51:09.457 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-06 20:51:09.473 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0e, 0x00, 0xe7
2021-09-06 20:51:09.474 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0e received (expected 0x0e)
2021-09-06 20:51:09.474 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-06 20:51:09.474 Detail, Expected callbackId was received
2021-09-06 20:51:09.482 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-06 20:51:09.483 Detail,
2021-09-06 20:51:09.483 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-06 20:51:09.483 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-06 20:51:09.483 Detail, Node002, Initial read of value
2021-09-06 20:51:09.483 Detail, Node002, Expected reply and command class was received
2021-09-06 20:51:09.483 Detail, Node002, Message transaction complete
2021-09-06 20:51:09.483 Detail,
2021-09-06 20:51:09.483 Detail, Node002, Removing current message
2021-09-06 20:51:09.483 Detail, Node002, Notification: ValueChanged
2021-09-06 20:51:09.510 Detail, Node002, Query Stage Complete (Dynamic)
2021-09-06 20:51:09.510 Detail, Node002, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Configuration live=1
2021-09-06 20:51:09.510 Detail, Node002, QueryStage_Configuration
2021-09-06 20:51:09.510 Detail, Node002, QueryStage_Complete
2021-09-06 20:51:09.510 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2021-09-06 20:51:09.510 Warning, CheckCompletedNodeQueries all=1, deadFound=0 sleepingOnly=1
2021-09-06 20:51:09.510 Info, Node query processing complete.
2021-09-06 20:51:09.511 Detail, Node002, Notification: NodeQueriesComplete
2021-09-06 20:51:09.534 Detail, contrlr, Notification: AllNodesQueried
2021-09-07 00:00:48.739 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-07 00:00:48.742 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-07 00:00:48.742 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x0f, 0xe9
2021-09-07 00:00:48.742 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x10, 0xf7
2021-09-07 00:00:48.743 Detail,
2021-09-07 00:00:48.743 Info, Node002, Sending (Send) message (Callback ID=0x0f, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x0f, 0xe9
2021-09-07 00:00:48.750 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-07 00:00:48.750 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-07 00:00:48.766 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x0f, 0x00, 0xe6
2021-09-07 00:00:48.766 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x0f received (expected 0x0f)
2021-09-07 00:00:48.767 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-07 00:00:48.767 Detail, Expected callbackId was received
2021-09-07 00:00:48.767 Detail, Expected reply was received
2021-09-07 00:00:48.767 Detail, Message transaction complete
2021-09-07 00:00:48.767 Detail,
2021-09-07 00:00:48.767 Detail, Node002, Removing current message
2021-09-07 00:00:48.767 Detail,
2021-09-07 00:00:48.767 Info, Node002, Sending (Send) message (Callback ID=0x10, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x10, 0xf7
2021-09-07 00:00:48.774 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-07 00:00:48.774 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-07 00:00:48.789 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x10, 0x00, 0xf9
2021-09-07 00:00:48.789 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x10 received (expected 0x10)
2021-09-07 00:00:48.790 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-07 00:00:48.790 Detail, Expected callbackId was received
2021-09-07 00:00:48.798 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-07 00:00:48.798 Detail,
2021-09-07 00:00:48.798 Info, Node002, Response RTT 30 Average Response RTT 30
2021-09-07 00:00:48.798 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-07 00:00:48.798 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-07 00:00:48.798 Detail, Node002, Changes to this value are not verified
2021-09-07 00:00:48.799 Detail, Node002, Expected reply and command class was received
2021-09-07 00:00:48.799 Detail, Node002, Message transaction complete
2021-09-07 00:00:48.799 Detail,
2021-09-07 00:00:48.799 Detail, Node002, Removing current message
2021-09-07 00:00:48.799 Detail, Node002, Notification: ValueChanged
2021-09-07 19:13:51.753 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-07 19:13:51.753 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-07 19:13:51.753 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x11, 0x08
2021-09-07 19:13:51.754 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x12, 0xf5
2021-09-07 19:13:51.754 Detail,
2021-09-07 19:13:51.754 Info, Node002, Sending (Send) message (Callback ID=0x11, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x11, 0x08
2021-09-07 19:13:51.760 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-07 19:13:51.761 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-07 19:13:51.777 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x11, 0x00, 0xf8
2021-09-07 19:13:51.777 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x11 received (expected 0x11)
2021-09-07 19:13:51.777 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-07 19:13:51.777 Detail, Expected callbackId was received
2021-09-07 19:13:51.777 Detail, Expected reply was received
2021-09-07 19:13:51.777 Detail, Message transaction complete
2021-09-07 19:13:51.777 Detail,
2021-09-07 19:13:51.777 Detail, Node002, Removing current message
2021-09-07 19:13:51.778 Detail,
2021-09-07 19:13:51.778 Info, Node002, Sending (Send) message (Callback ID=0x12, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x12, 0xf5
2021-09-07 19:13:51.784 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-07 19:13:51.785 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-07 19:13:51.800 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x12, 0x00, 0xfb
2021-09-07 19:13:51.800 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x12 received (expected 0x12)
2021-09-07 19:13:51.800 Info, Node002, Request RTT 21 Average Request RTT 21
2021-09-07 19:13:51.800 Detail, Expected callbackId was received
2021-09-07 19:13:51.810 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-07 19:13:51.810 Detail,
2021-09-07 19:13:51.810 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-07 19:13:51.810 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-07 19:13:51.810 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-07 19:13:51.810 Detail, Node002, Changes to this value are not verified
2021-09-07 19:13:51.810 Detail, Node002, Expected reply and command class was received
2021-09-07 19:13:51.810 Detail, Node002, Message transaction complete
2021-09-07 19:13:51.810 Detail,
2021-09-07 19:13:51.811 Detail, Node002, Removing current message
2021-09-07 19:13:51.811 Detail, Node002, Notification: ValueChanged
2021-09-08 00:00:52.014 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-08 00:00:52.014 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-08 00:00:52.014 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x13, 0xf5
2021-09-08 00:00:52.014 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x14, 0xf3
2021-09-08 00:00:52.014 Detail,
2021-09-08 00:00:52.015 Info, Node002, Sending (Send) message (Callback ID=0x13, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x13, 0xf5
2021-09-08 00:00:52.022 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-08 00:00:52.022 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-08 00:00:52.037 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x13, 0x00, 0xfa
2021-09-08 00:00:52.037 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x13 received (expected 0x13)
2021-09-08 00:00:52.037 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-08 00:00:52.037 Detail, Expected callbackId was received
2021-09-08 00:00:52.038 Detail, Expected reply was received
2021-09-08 00:00:52.038 Detail, Message transaction complete
2021-09-08 00:00:52.038 Detail,
2021-09-08 00:00:52.038 Detail, Node002, Removing current message
2021-09-08 00:00:52.038 Detail,
2021-09-08 00:00:52.038 Info, Node002, Sending (Send) message (Callback ID=0x14, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x14, 0xf3
2021-09-08 00:00:52.045 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-08 00:00:52.045 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-08 00:00:52.060 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x14, 0x00, 0xfd
2021-09-08 00:00:52.060 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x14 received (expected 0x14)
2021-09-08 00:00:52.060 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-08 00:00:52.060 Detail, Expected callbackId was received
2021-09-08 00:00:52.068 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-08 00:00:52.068 Detail,
2021-09-08 00:00:52.068 Info, Node002, Response RTT 29 Average Response RTT 29
2021-09-08 00:00:52.068 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-08 00:00:52.068 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-08 00:00:52.068 Detail, Node002, Changes to this value are not verified
2021-09-08 00:00:52.068 Detail, Node002, Expected reply and command class was received
2021-09-08 00:00:52.068 Detail, Node002, Message transaction complete
2021-09-08 00:00:52.069 Detail,
2021-09-08 00:00:52.069 Detail, Node002, Removing current message
2021-09-08 00:00:52.069 Detail, Node002, Notification: ValueChanged
2021-09-08 19:12:53.815 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-08 19:12:53.815 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-08 19:12:53.815 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x15, 0x0c
2021-09-08 19:12:53.815 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x16, 0xf1
2021-09-08 19:12:53.815 Detail,
2021-09-08 19:12:53.816 Info, Node002, Sending (Send) message (Callback ID=0x15, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x15, 0x0c
2021-09-08 19:12:53.822 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-08 19:12:53.822 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-08 19:12:53.838 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x15, 0x00, 0xfc
2021-09-08 19:12:53.839 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x15 received (expected 0x15)
2021-09-08 19:12:53.839 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-08 19:12:53.839 Detail, Expected callbackId was received
2021-09-08 19:12:53.839 Detail, Expected reply was received
2021-09-08 19:12:53.839 Detail, Message transaction complete
2021-09-08 19:12:53.839 Detail,
2021-09-08 19:12:53.839 Detail, Node002, Removing current message
2021-09-08 19:12:53.839 Detail,
2021-09-08 19:12:53.839 Info, Node002, Sending (Send) message (Callback ID=0x16, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x16, 0xf1
2021-09-08 19:12:53.846 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-08 19:12:53.846 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-08 19:12:53.861 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x16, 0x00, 0xff
2021-09-08 19:12:53.862 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x16 received (expected 0x16)
2021-09-08 19:12:53.862 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-08 19:12:53.862 Detail, Expected callbackId was received
2021-09-08 19:12:53.870 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-08 19:12:53.870 Detail,
2021-09-08 19:12:53.871 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-08 19:12:53.871 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-08 19:12:53.871 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-08 19:12:53.871 Detail, Node002, Changes to this value are not verified
2021-09-08 19:12:53.871 Detail, Node002, Expected reply and command class was received
2021-09-08 19:12:53.871 Detail, Node002, Message transaction complete
2021-09-08 19:12:53.871 Detail,
2021-09-08 19:12:53.871 Detail, Node002, Removing current message
2021-09-08 19:12:53.871 Detail, Node002, Notification: ValueChanged
2021-09-09 00:00:54.393 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-09 00:00:54.393 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-09 00:00:54.393 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x17, 0xf1
2021-09-09 00:00:54.393 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x18, 0xff
2021-09-09 00:00:54.394 Detail,
2021-09-09 00:00:54.394 Info, Node002, Sending (Send) message (Callback ID=0x17, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x17, 0xf1
2021-09-09 00:00:54.401 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-09 00:00:54.401 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-09 00:00:54.416 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x17, 0x00, 0xfe
2021-09-09 00:00:54.416 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x17 received (expected 0x17)
2021-09-09 00:00:54.416 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-09 00:00:54.416 Detail, Expected callbackId was received
2021-09-09 00:00:54.416 Detail, Expected reply was received
2021-09-09 00:00:54.416 Detail, Message transaction complete
2021-09-09 00:00:54.416 Detail,
2021-09-09 00:00:54.416 Detail, Node002, Removing current message
2021-09-09 00:00:54.417 Detail,
2021-09-09 00:00:54.417 Info, Node002, Sending (Send) message (Callback ID=0x18, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x18, 0xff
2021-09-09 00:00:54.424 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-09 00:00:54.424 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-09 00:00:54.439 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x18, 0x00, 0xf1
2021-09-09 00:00:54.439 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x18 received (expected 0x18)
2021-09-09 00:00:54.439 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-09 00:00:54.439 Detail, Expected callbackId was received
2021-09-09 00:00:54.448 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-09 00:00:54.448 Detail,
2021-09-09 00:00:54.448 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-09 00:00:54.448 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-09 00:00:54.448 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-09 00:00:54.448 Detail, Node002, Changes to this value are not verified
2021-09-09 00:00:54.448 Detail, Node002, Expected reply and command class was received
2021-09-09 00:00:54.448 Detail, Node002, Message transaction complete
2021-09-09 00:00:54.449 Detail,
2021-09-09 00:00:54.449 Detail, Node002, Removing current message
2021-09-09 00:00:54.449 Detail, Node002, Notification: ValueChanged
2021-09-09 19:10:56.664 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-09 19:10:56.665 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-09 19:10:56.665 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x19, 0x00
2021-09-09 19:10:56.665 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1a, 0xfd
2021-09-09 19:10:56.666 Detail,
2021-09-09 19:10:56.666 Info, Node002, Sending (Send) message (Callback ID=0x19, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x19, 0x00
2021-09-09 19:10:56.672 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-09 19:10:56.673 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-09 19:10:56.689 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x19, 0x00, 0xf0
2021-09-09 19:10:56.689 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x19 received (expected 0x19)
2021-09-09 19:10:56.689 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-09 19:10:56.689 Detail, Expected callbackId was received
2021-09-09 19:10:56.689 Detail, Expected reply was received
2021-09-09 19:10:56.689 Detail, Message transaction complete
2021-09-09 19:10:56.689 Detail,
2021-09-09 19:10:56.689 Detail, Node002, Removing current message
2021-09-09 19:10:56.689 Detail,
2021-09-09 19:10:56.689 Info, Node002, Sending (Send) message (Callback ID=0x1a, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1a, 0xfd
2021-09-09 19:10:56.696 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-09 19:10:56.697 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-09 19:10:56.711 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1a, 0x00, 0xf3
2021-09-09 19:10:56.712 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1a received (expected 0x1a)
2021-09-09 19:10:56.712 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-09 19:10:56.712 Detail, Expected callbackId was received
2021-09-09 19:10:56.720 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-09 19:10:56.721 Detail,
2021-09-09 19:10:56.721 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-09 19:10:56.721 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-09 19:10:56.721 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-09 19:10:56.721 Detail, Node002, Changes to this value are not verified
2021-09-09 19:10:56.721 Detail, Node002, Expected reply and command class was received
2021-09-09 19:10:56.721 Detail, Node002, Message transaction complete
2021-09-09 19:10:56.721 Detail,
2021-09-09 19:10:56.721 Detail, Node002, Removing current message
2021-09-09 19:10:56.721 Detail, Node002, Notification: ValueChanged
2021-09-10 00:00:57.232 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-10 00:00:57.232 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-10 00:00:57.232 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x1b, 0xfd
2021-09-10 00:00:57.233 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1c, 0xfb
2021-09-10 00:00:57.233 Detail,
2021-09-10 00:00:57.233 Info, Node002, Sending (Send) message (Callback ID=0x1b, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x1b, 0xfd
2021-09-10 00:00:57.241 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-10 00:00:57.241 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-10 00:00:57.256 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1b, 0x00, 0xf2
2021-09-10 00:00:57.256 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1b received (expected 0x1b)
2021-09-10 00:00:57.256 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-10 00:00:57.256 Detail, Expected callbackId was received
2021-09-10 00:00:57.256 Detail, Expected reply was received
2021-09-10 00:00:57.256 Detail, Message transaction complete
2021-09-10 00:00:57.256 Detail,
2021-09-10 00:00:57.256 Detail, Node002, Removing current message
2021-09-10 00:00:57.256 Detail,
2021-09-10 00:00:57.257 Info, Node002, Sending (Send) message (Callback ID=0x1c, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1c, 0xfb
2021-09-10 00:00:57.263 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-10 00:00:57.264 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-10 00:00:57.279 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1c, 0x00, 0xf5
2021-09-10 00:00:57.279 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1c received (expected 0x1c)
2021-09-10 00:00:57.279 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-10 00:00:57.279 Detail, Expected callbackId was received
2021-09-10 00:00:57.287 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-10 00:00:57.288 Detail,
2021-09-10 00:00:57.288 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-10 00:00:57.288 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-10 00:00:57.288 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-10 00:00:57.288 Detail, Node002, Changes to this value are not verified
2021-09-10 00:00:57.288 Detail, Node002, Expected reply and command class was received
2021-09-10 00:00:57.288 Detail, Node002, Message transaction complete
2021-09-10 00:00:57.288 Detail,
2021-09-10 00:00:57.288 Detail, Node002, Removing current message
2021-09-10 00:00:57.289 Detail, Node002, Notification: ValueChanged
2021-09-10 19:08:59.075 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-10 19:08:59.075 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-10 19:08:59.076 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x1d, 0x04
2021-09-10 19:08:59.076 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1e, 0xf9
2021-09-10 19:08:59.076 Detail,
2021-09-10 19:08:59.076 Info, Node002, Sending (Send) message (Callback ID=0x1d, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x1d, 0x04
2021-09-10 19:08:59.083 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-10 19:08:59.083 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-10 19:08:59.099 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1d, 0x00, 0xf4
2021-09-10 19:08:59.099 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1d received (expected 0x1d)
2021-09-10 19:08:59.099 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-10 19:08:59.099 Detail, Expected callbackId was received
2021-09-10 19:08:59.099 Detail, Expected reply was received
2021-09-10 19:08:59.100 Detail, Message transaction complete
2021-09-10 19:08:59.100 Detail,
2021-09-10 19:08:59.100 Detail, Node002, Removing current message
2021-09-10 19:08:59.100 Detail,
2021-09-10 19:08:59.100 Info, Node002, Sending (Send) message (Callback ID=0x1e, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x1e, 0xf9
2021-09-10 19:08:59.107 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-10 19:08:59.107 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-10 19:08:59.122 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1e, 0x00, 0xf7
2021-09-10 19:08:59.122 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1e received (expected 0x1e)
2021-09-10 19:08:59.122 Info, Node002, Request RTT 22 Average Request RTT 21
2021-09-10 19:08:59.122 Detail, Expected callbackId was received
2021-09-10 19:08:59.131 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-10 19:08:59.131 Detail,
2021-09-10 19:08:59.131 Info, Node002, Response RTT 31 Average Response RTT 30
2021-09-10 19:08:59.131 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-10 19:08:59.131 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-10 19:08:59.131 Detail, Node002, Changes to this value are not verified
2021-09-10 19:08:59.132 Detail, Node002, Expected reply and command class was received
2021-09-10 19:08:59.132 Detail, Node002, Message transaction complete
2021-09-10 19:08:59.132 Detail,
2021-09-10 19:08:59.132 Detail, Node002, Removing current message
2021-09-10 19:08:59.132 Detail, Node002, Notification: ValueChanged
2021-09-11 00:00:59.716 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-11 00:00:59.717 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-11 00:00:59.717 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x1f, 0xf9
2021-09-11 00:00:59.717 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x20, 0xc7
2021-09-11 00:00:59.717 Detail,
2021-09-11 00:00:59.718 Info, Node002, Sending (Send) message (Callback ID=0x1f, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x1f, 0xf9
2021-09-11 00:00:59.725 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-11 00:00:59.725 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-11 00:00:59.741 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x1f, 0x00, 0xf6
2021-09-11 00:00:59.741 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x1f received (expected 0x1f)
2021-09-11 00:00:59.741 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-11 00:00:59.742 Detail, Expected callbackId was received
2021-09-11 00:00:59.742 Detail, Expected reply was received
2021-09-11 00:00:59.742 Detail, Message transaction complete
2021-09-11 00:00:59.742 Detail,
2021-09-11 00:00:59.742 Detail, Node002, Removing current message
2021-09-11 00:00:59.742 Detail,
2021-09-11 00:00:59.742 Info, Node002, Sending (Send) message (Callback ID=0x20, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x20, 0xc7
2021-09-11 00:00:59.749 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-11 00:00:59.749 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-11 00:00:59.764 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x20, 0x00, 0xc9
2021-09-11 00:00:59.764 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x20 received (expected 0x20)
2021-09-11 00:00:59.764 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-11 00:00:59.764 Detail, Expected callbackId was received
2021-09-11 00:00:59.774 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-11 00:00:59.774 Detail,
2021-09-11 00:00:59.775 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-11 00:00:59.775 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-11 00:00:59.775 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-11 00:00:59.775 Detail, Node002, Changes to this value are not verified
2021-09-11 00:00:59.775 Detail, Node002, Expected reply and command class was received
2021-09-11 00:00:59.775 Detail, Node002, Message transaction complete
2021-09-11 00:00:59.775 Detail,
2021-09-11 00:00:59.775 Detail, Node002, Removing current message
2021-09-11 00:00:59.775 Detail, Node002, Notification: ValueChanged
2021-09-11 19:08:01.521 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-11 19:08:01.521 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-11 19:08:01.521 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x21, 0x38
2021-09-11 19:08:01.522 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x22, 0xc5
2021-09-11 19:08:01.522 Detail,
2021-09-11 19:08:01.522 Info, Node002, Sending (Send) message (Callback ID=0x21, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x21, 0x38
2021-09-11 19:08:01.529 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-11 19:08:01.529 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-11 19:08:01.545 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x21, 0x00, 0xc8
2021-09-11 19:08:01.545 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x21 received (expected 0x21)
2021-09-11 19:08:01.545 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-11 19:08:01.546 Detail, Expected callbackId was received
2021-09-11 19:08:01.546 Detail, Expected reply was received
2021-09-11 19:08:01.546 Detail, Message transaction complete
2021-09-11 19:08:01.546 Detail,
2021-09-11 19:08:01.546 Detail, Node002, Removing current message
2021-09-11 19:08:01.546 Detail,
2021-09-11 19:08:01.546 Info, Node002, Sending (Send) message (Callback ID=0x22, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x22, 0xc5
2021-09-11 19:08:01.553 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-11 19:08:01.553 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-11 19:08:01.568 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x22, 0x00, 0xcb
2021-09-11 19:08:01.568 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x22 received (expected 0x22)
2021-09-11 19:08:01.568 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-11 19:08:01.569 Detail, Expected callbackId was received
2021-09-11 19:08:01.578 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-11 19:08:01.578 Detail,
2021-09-11 19:08:01.579 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-11 19:08:01.579 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-11 19:08:01.579 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-11 19:08:01.579 Detail, Node002, Changes to this value are not verified
2021-09-11 19:08:01.579 Detail, Node002, Expected reply and command class was received
2021-09-11 19:08:01.579 Detail, Node002, Message transaction complete
2021-09-11 19:08:01.579 Detail,
2021-09-11 19:08:01.579 Detail, Node002, Removing current message
2021-09-11 19:08:01.579 Detail, Node002, Notification: ValueChanged
2021-09-12 00:00:01.790 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-12 00:00:01.791 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-12 00:00:01.791 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x23, 0xc5
2021-09-12 00:00:01.791 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x24, 0xc3
2021-09-12 00:00:01.791 Detail,
2021-09-12 00:00:01.792 Info, Node002, Sending (Send) message (Callback ID=0x23, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x23, 0xc5
2021-09-12 00:00:01.799 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-12 00:00:01.799 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-12 00:00:01.814 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x23, 0x00, 0xca
2021-09-12 00:00:01.814 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x23 received (expected 0x23)
2021-09-12 00:00:01.814 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-12 00:00:01.814 Detail, Expected callbackId was received
2021-09-12 00:00:01.814 Detail, Expected reply was received
2021-09-12 00:00:01.814 Detail, Message transaction complete
2021-09-12 00:00:01.814 Detail,
2021-09-12 00:00:01.814 Detail, Node002, Removing current message
2021-09-12 00:00:01.815 Detail,
2021-09-12 00:00:01.815 Info, Node002, Sending (Send) message (Callback ID=0x24, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x24, 0xc3
2021-09-12 00:00:01.822 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-12 00:00:01.822 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-12 00:00:01.837 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x24, 0x00, 0xcd
2021-09-12 00:00:01.837 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x24 received (expected 0x24)
2021-09-12 00:00:01.837 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-12 00:00:01.837 Detail, Expected callbackId was received
2021-09-12 00:00:01.847 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-12 00:00:01.847 Detail,
2021-09-12 00:00:01.847 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-12 00:00:01.847 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-12 00:00:01.847 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-12 00:00:01.847 Detail, Node002, Changes to this value are not verified
2021-09-12 00:00:01.848 Detail, Node002, Expected reply and command class was received
2021-09-12 00:00:01.848 Detail, Node002, Message transaction complete
2021-09-12 00:00:01.848 Detail,
2021-09-12 00:00:01.848 Detail, Node002, Removing current message
2021-09-12 00:00:01.848 Detail, Node002, Notification: ValueChanged
2021-09-13 19:04:06.264 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-13 19:04:06.265 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-13 19:04:06.265 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x25, 0x3c
2021-09-13 19:04:06.265 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x26, 0xc1
2021-09-13 19:04:06.266 Detail,
2021-09-13 19:04:06.266 Info, Node002, Sending (Send) message (Callback ID=0x25, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x25, 0x3c
2021-09-13 19:04:06.272 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-13 19:04:06.273 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-13 19:04:06.289 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x25, 0x00, 0xcc
2021-09-13 19:04:06.289 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x25 received (expected 0x25)
2021-09-13 19:04:06.289 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-13 19:04:06.289 Detail, Expected callbackId was received
2021-09-13 19:04:06.289 Detail, Expected reply was received
2021-09-13 19:04:06.289 Detail, Message transaction complete
2021-09-13 19:04:06.289 Detail,
2021-09-13 19:04:06.289 Detail, Node002, Removing current message
2021-09-13 19:04:06.290 Detail,
2021-09-13 19:04:06.290 Info, Node002, Sending (Send) message (Callback ID=0x26, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x26, 0xc1
2021-09-13 19:04:06.296 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-13 19:04:06.297 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-13 19:04:06.312 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x26, 0x00, 0xcf
2021-09-13 19:04:06.312 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x26 received (expected 0x26)
2021-09-13 19:04:06.312 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-13 19:04:06.312 Detail, Expected callbackId was received
2021-09-13 19:04:06.322 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-13 19:04:06.322 Detail,
2021-09-13 19:04:06.322 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-13 19:04:06.322 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-13 19:04:06.322 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-13 19:04:06.322 Detail, Node002, Changes to this value are not verified
2021-09-13 19:04:06.323 Detail, Node002, Expected reply and command class was received
2021-09-13 19:04:06.323 Detail, Node002, Message transaction complete
2021-09-13 19:04:06.323 Detail,
2021-09-13 19:04:06.323 Detail, Node002, Removing current message
2021-09-13 19:04:06.323 Detail, Node002, Notification: ValueChanged
2021-09-14 00:00:06.733 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - False
2021-09-14 00:00:06.734 Info, Node002, SwitchBinary::Set - Setting node 2 to Off
2021-09-14 00:00:06.734 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x27, 0xc1
2021-09-14 00:00:06.734 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x28, 0xcf
2021-09-14 00:00:06.735 Detail,
2021-09-14 00:00:06.735 Info, Node002, Sending (Send) message (Callback ID=0x27, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0x00, 0x25, 0x27, 0xc1
2021-09-14 00:00:06.741 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 00:00:06.742 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 00:00:06.758 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x27, 0x00, 0xce
2021-09-14 00:00:06.758 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x27 received (expected 0x27)
2021-09-14 00:00:06.758 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-14 00:00:06.758 Detail, Expected callbackId was received
2021-09-14 00:00:06.758 Detail, Expected reply was received
2021-09-14 00:00:06.758 Detail, Message transaction complete
2021-09-14 00:00:06.758 Detail,
2021-09-14 00:00:06.758 Detail, Node002, Removing current message
2021-09-14 00:00:06.759 Detail,
2021-09-14 00:00:06.759 Info, Node002, Sending (Send) message (Callback ID=0x28, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x28, 0xcf
2021-09-14 00:00:06.766 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 00:00:06.766 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 00:00:06.781 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x28, 0x00, 0xc1
2021-09-14 00:00:06.781 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x28 received (expected 0x28)
2021-09-14 00:00:06.781 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 00:00:06.781 Detail, Expected callbackId was received
2021-09-14 00:00:06.791 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0x00, 0xd5
2021-09-14 00:00:06.791 Detail,
2021-09-14 00:00:06.791 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-14 00:00:06.791 Info, Node002, Received SwitchBinary report from node 2: level=Off
2021-09-14 00:00:06.791 Detail, Node002, Refreshed Value: old value=true, new value=false, type=bool
2021-09-14 00:00:06.791 Detail, Node002, Changes to this value are not verified
2021-09-14 00:00:06.792 Detail, Node002, Expected reply and command class was received
2021-09-14 00:00:06.792 Detail, Node002, Message transaction complete
2021-09-14 00:00:06.792 Detail,
2021-09-14 00:00:06.792 Detail, Node002, Removing current message
2021-09-14 00:00:06.792 Detail, Node002, Notification: ValueChanged
2021-09-14 19:02:09.000 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-14 19:02:09.000 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-14 19:02:09.000 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x29, 0x30
2021-09-14 19:02:09.000 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2a, 0xcd
2021-09-14 19:02:09.000 Detail,
2021-09-14 19:02:09.000 Info, Node002, Sending (Send) message (Callback ID=0x29, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x29, 0x30
2021-09-14 19:02:09.008 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 19:02:09.008 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 19:02:09.023 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x29, 0x00, 0xc0
2021-09-14 19:02:09.023 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x29 received (expected 0x29)
2021-09-14 19:02:09.023 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 19:02:09.023 Detail, Expected callbackId was received
2021-09-14 19:02:09.023 Detail, Expected reply was received
2021-09-14 19:02:09.024 Detail, Message transaction complete
2021-09-14 19:02:09.024 Detail,
2021-09-14 19:02:09.024 Detail, Node002, Removing current message
2021-09-14 19:02:09.024 Detail,
2021-09-14 19:02:09.024 Info, Node002, Sending (Send) message (Callback ID=0x2a, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2a, 0xcd
2021-09-14 19:02:09.031 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 19:02:09.031 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 19:02:09.047 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2a, 0x00, 0xc3
2021-09-14 19:02:09.047 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2a received (expected 0x2a)
2021-09-14 19:02:09.047 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-14 19:02:09.048 Detail, Expected callbackId was received
2021-09-14 19:02:09.056 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-14 19:02:09.056 Detail,
2021-09-14 19:02:09.056 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-14 19:02:09.056 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-14 19:02:09.057 Detail, Node002, Refreshed Value: old value=false, new value=true, type=bool
2021-09-14 19:02:09.057 Detail, Node002, Changes to this value are not verified
2021-09-14 19:02:09.057 Detail, Node002, Expected reply and command class was received
2021-09-14 19:02:09.057 Detail, Node002, Message transaction complete
2021-09-14 19:02:09.057 Detail,
2021-09-14 19:02:09.057 Detail, Node002, Removing current message
2021-09-14 19:02:09.057 Detail, Node002, Notification: ValueChanged
2021-09-14 20:21:01.887 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-14 20:21:01.887 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-14 20:21:01.887 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2b, 0x32
2021-09-14 20:21:01.887 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2c, 0xcb
2021-09-14 20:21:01.887 Detail,
2021-09-14 20:21:01.887 Info, Node002, Sending (Send) message (Callback ID=0x2b, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2b, 0x32
2021-09-14 20:21:01.895 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 20:21:01.895 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 20:21:01.910 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2b, 0x00, 0xc2
2021-09-14 20:21:01.910 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2b received (expected 0x2b)
2021-09-14 20:21:01.910 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 20:21:01.910 Detail, Expected callbackId was received
2021-09-14 20:21:01.910 Detail, Expected reply was received
2021-09-14 20:21:01.910 Detail, Message transaction complete
2021-09-14 20:21:01.910 Detail,
2021-09-14 20:21:01.910 Detail, Node002, Removing current message
2021-09-14 20:21:01.911 Detail,
2021-09-14 20:21:01.911 Info, Node002, Sending (Send) message (Callback ID=0x2c, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2c, 0xcb
2021-09-14 20:21:01.918 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 20:21:01.918 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 20:21:01.933 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2c, 0x00, 0xc5
2021-09-14 20:21:01.933 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2c received (expected 0x2c)
2021-09-14 20:21:01.933 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 20:21:01.933 Detail, Expected callbackId was received
2021-09-14 20:21:01.943 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-14 20:21:01.943 Detail,
2021-09-14 20:21:01.943 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-14 20:21:01.943 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-14 20:21:01.943 Detail, Node002, Refreshed Value: old value=true, new value=true, type=bool
2021-09-14 20:21:01.943 Detail, Node002, Changes to this value are not verified
2021-09-14 20:21:01.944 Detail, Node002, Expected reply and command class was received
2021-09-14 20:21:01.944 Detail, Node002, Message transaction complete
2021-09-14 20:21:01.944 Detail,
2021-09-14 20:21:01.944 Detail, Node002, Removing current message
2021-09-14 20:21:01.944 Detail, Node002, Notification: ValueChanged
2021-09-14 22:57:38.642 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-14 22:57:38.643 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-14 22:57:38.643 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2d, 0x34
2021-09-14 22:57:38.643 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2e, 0xc9
2021-09-14 22:57:38.643 Detail,
2021-09-14 22:57:38.643 Info, Node002, Sending (Send) message (Callback ID=0x2d, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2d, 0x34
2021-09-14 22:57:38.651 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 22:57:38.651 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 22:57:38.666 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2d, 0x00, 0xc4
2021-09-14 22:57:38.666 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2d received (expected 0x2d)
2021-09-14 22:57:38.666 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 22:57:38.666 Detail, Expected callbackId was received
2021-09-14 22:57:38.666 Detail, Expected reply was received
2021-09-14 22:57:38.666 Detail, Message transaction complete
2021-09-14 22:57:38.666 Detail,
2021-09-14 22:57:38.666 Detail, Node002, Removing current message
2021-09-14 22:57:38.667 Detail,
2021-09-14 22:57:38.667 Info, Node002, Sending (Send) message (Callback ID=0x2e, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x2e, 0xc9
2021-09-14 22:57:38.673 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 22:57:38.674 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 22:57:38.689 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2e, 0x00, 0xc7
2021-09-14 22:57:38.689 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2e received (expected 0x2e)
2021-09-14 22:57:38.689 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 22:57:38.689 Detail, Expected callbackId was received
2021-09-14 22:57:38.699 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-14 22:57:38.699 Detail,
2021-09-14 22:57:38.699 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-14 22:57:38.699 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-14 22:57:38.699 Detail, Node002, Refreshed Value: old value=true, new value=true, type=bool
2021-09-14 22:57:38.699 Detail, Node002, Changes to this value are not verified
2021-09-14 22:57:38.699 Detail, Node002, Expected reply and command class was received
2021-09-14 22:57:38.700 Detail, Node002, Message transaction complete
2021-09-14 22:57:38.700 Detail,
2021-09-14 22:57:38.700 Detail, Node002, Removing current message
2021-09-14 22:57:38.700 Detail, Node002, Notification: ValueChanged
2021-09-14 23:00:04.517 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-14 23:00:04.518 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-14 23:00:04.518 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2f, 0x36
2021-09-14 23:00:04.518 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x30, 0xd7
2021-09-14 23:00:04.518 Detail,
2021-09-14 23:00:04.518 Info, Node002, Sending (Send) message (Callback ID=0x2f, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x2f, 0x36
2021-09-14 23:00:04.525 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 23:00:04.525 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 23:00:04.541 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x2f, 0x00, 0xc6
2021-09-14 23:00:04.541 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x2f received (expected 0x2f)
2021-09-14 23:00:04.542 Info, Node002, Request RTT 23 Average Request RTT 22
2021-09-14 23:00:04.542 Detail, Expected callbackId was received
2021-09-14 23:00:04.542 Detail, Expected reply was received
2021-09-14 23:00:04.542 Detail, Message transaction complete
2021-09-14 23:00:04.542 Detail,
2021-09-14 23:00:04.542 Detail, Node002, Removing current message
2021-09-14 23:00:04.542 Detail,
2021-09-14 23:00:04.542 Info, Node002, Sending (Send) message (Callback ID=0x30, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x30, 0xd7
2021-09-14 23:00:04.549 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 23:00:04.549 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 23:00:04.564 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x30, 0x00, 0xd9
2021-09-14 23:00:04.564 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x30 received (expected 0x30)
2021-09-14 23:00:04.564 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 23:00:04.564 Detail, Expected callbackId was received
2021-09-14 23:00:04.573 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-14 23:00:04.573 Detail,
2021-09-14 23:00:04.573 Info, Node002, Response RTT 31 Average Response RTT 31
2021-09-14 23:00:04.573 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-14 23:00:04.573 Detail, Node002, Refreshed Value: old value=true, new value=true, type=bool
2021-09-14 23:00:04.574 Detail, Node002, Changes to this value are not verified
2021-09-14 23:00:04.574 Detail, Node002, Expected reply and command class was received
2021-09-14 23:00:04.574 Detail, Node002, Message transaction complete
2021-09-14 23:00:04.574 Detail,
2021-09-14 23:00:04.574 Detail, Node002, Removing current message
2021-09-14 23:00:04.574 Detail, Node002, Notification: ValueChanged
2021-09-14 23:04:19.172 Info, Node002, Value::Set - COMMAND_CLASS_SWITCH_BINARY - Switch - 0 - 1 - True
2021-09-14 23:04:19.173 Info, Node002, SwitchBinary::Set - Setting node 2 to On
2021-09-14 23:04:19.173 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x31, 0x28
2021-09-14 23:04:19.173 Detail, Node002, Queuing (Send) SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x32, 0xd5
2021-09-14 23:04:19.173 Detail,
2021-09-14 23:04:19.173 Info, Node002, Sending (Send) message (Callback ID=0x31, Expected Reply=0x13) - SwitchBinaryCmd_Set (Node=2): 0x01, 0x0a, 0x00, 0x13, 0x02, 0x03, 0x25, 0x01, 0xff, 0x25, 0x31, 0x28
2021-09-14 23:04:19.180 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 23:04:19.180 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 23:04:19.196 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x31, 0x00, 0xd8
2021-09-14 23:04:19.197 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x31 received (expected 0x31)
2021-09-14 23:04:19.197 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 23:04:19.197 Detail, Expected callbackId was received
2021-09-14 23:04:19.197 Detail, Expected reply was received
2021-09-14 23:04:19.197 Detail, Message transaction complete
2021-09-14 23:04:19.197 Detail,
2021-09-14 23:04:19.197 Detail, Node002, Removing current message
2021-09-14 23:04:19.197 Detail,
2021-09-14 23:04:19.197 Info, Node002, Sending (Send) message (Callback ID=0x32, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=2): 0x01, 0x09, 0x00, 0x13, 0x02, 0x02, 0x25, 0x02, 0x25, 0x32, 0xd5
2021-09-14 23:04:19.204 Detail, Node002, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2021-09-14 23:04:19.204 Detail, Node002, ZW_SEND_DATA delivered to Z-Wave stack
2021-09-14 23:04:19.219 Detail, Node002, Received: 0x01, 0x05, 0x00, 0x13, 0x32, 0x00, 0xdb
2021-09-14 23:04:19.220 Detail, Node002, ZW_SEND_DATA Request with callback ID 0x32 received (expected 0x32)
2021-09-14 23:04:19.220 Info, Node002, Request RTT 22 Average Request RTT 22
2021-09-14 23:04:19.220 Detail, Expected callbackId was received
2021-09-14 23:04:19.229 Detail, Node002, Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x02, 0x03, 0x25, 0x03, 0xff, 0x2a
2021-09-14 23:04:19.230 Detail,
2021-09-14 23:04:19.230 Info, Node002, Response RTT 32 Average Response RTT 31
2021-09-14 23:04:19.230 Info, Node002, Received SwitchBinary report from node 2: level=On
2021-09-14 23:04:19.230 Detail, Node002, Refreshed Value: old value=true, new value=true, type=bool
2021-09-14 23:04:19.230 Detail, Node002, Changes to this value are not verified
2021-09-14 23:04:19.230 Detail, Node002, Expected reply and command class was received
2021-09-14 23:04:19.230 Detail, Node002, Message transaction complete
2021-09-14 23:04:19.230 Detail,
2021-09-14 23:04:19.230 Detail, Node002, Removing current message
2021-09-14 23:04:19.230 Detail, Node002, Notification: ValueChanged

View File

@@ -0,0 +1,50 @@
blueprint:
name: Motion-activated Light
description: Turn on a light when motion is detected.
domain: automation
source_url: https://github.com/home-assistant/core/blob/dev/homeassistant/components/automation/blueprints/motion_light.yaml
input:
motion_entity:
name: Motion Sensor
selector:
entity:
domain: binary_sensor
device_class: motion
light_target:
name: Light
selector:
target:
entity:
domain: light
no_motion_wait:
name: Wait time
description: Time to leave the light on after last motion is detected.
default: 120
selector:
number:
min: 0
max: 3600
unit_of_measurement: seconds
# If motion is detected within the delay,
# we restart the script.
mode: restart
max_exceeded: silent
trigger:
platform: state
entity_id: !input motion_entity
from: "off"
to: "on"
action:
- service: light.turn_on
target: !input light_target
- wait_for_trigger:
platform: state
entity_id: !input motion_entity
from: "on"
to: "off"
- delay: !input no_motion_wait
- service: light.turn_off
target: !input light_target

View File

@@ -0,0 +1,43 @@
blueprint:
name: Zone Notification
description: Send a notification to a device when a person leaves a specific zone.
domain: automation
source_url: https://github.com/home-assistant/core/blob/dev/homeassistant/components/automation/blueprints/notify_leaving_zone.yaml
input:
person_entity:
name: Person
selector:
entity:
domain: person
zone_entity:
name: Zone
selector:
entity:
domain: zone
notify_device:
name: Device to notify
description: Device needs to run the official Home Assistant app to receive notifications.
selector:
device:
integration: mobile_app
trigger:
platform: state
entity_id: !input person_entity
variables:
zone_entity: !input zone_entity
# This is the state of the person when it's in this zone.
zone_state: "{{ states[zone_entity].name }}"
person_entity: !input person_entity
person_name: "{{ states[person_entity].name }}"
condition:
condition: template
value_template: "{{ trigger.from_state.state == zone_state and trigger.to_state.state != zone_state }}"
action:
domain: mobile_app
type: notify
device_id: !input notify_device
message: "{{ person_name }} has left {{ zone_state }}"

View File

@@ -0,0 +1,74 @@
blueprint:
name: Confirmable Notification
description: >-
A script that sends an actionable notification with a confirmation before
running the specified action.
domain: script
source_url: https://github.com/home-assistant/core/blob/master/homeassistant/components/script/blueprints/confirmable_notification.yaml
input:
notify_device:
name: Device to notify
description: Device needs to run the official Home Assistant app to receive notifications.
selector:
device:
integration: mobile_app
title:
name: "Title"
description: "The title of the button shown in the notification."
default: ""
selector:
text:
message:
name: "Message"
description: "The message body"
selector:
text:
confirm_text:
name: "Confirmation Text"
description: "Text to show on the confirmation button"
default: "Confirm"
selector:
text:
confirm_action:
name: "Confirmation Action"
description: "Action to run when notification is confirmed"
default: []
selector:
action:
dismiss_text:
name: "Dismiss Text"
description: "Text to show on the dismiss button"
default: "Dismiss"
selector:
text:
dismiss_action:
name: "Dismiss Action"
description: "Action to run when notification is dismissed"
default: []
selector:
action:
mode: restart
sequence:
- alias: "Send notification"
domain: mobile_app
type: notify
device_id: !input notify_device
title: !input title
message: !input message
data:
actions:
- action: "CONFIRM"
title: !input confirm_text
- action: "DISMISS"
title: !input dismiss_text
- alias: "Awaiting response"
wait_for_trigger:
- platform: event
event_type: mobile_app_notification_action
- choose:
- conditions: "{{ wait.trigger.event.data.action == 'CONFIRM' }}"
sequence: !input confirm_action
- conditions: "{{ wait.trigger.event.data.action == 'DISMISS' }}"
sequence: !input dismiss_action

View File

@@ -16,6 +16,11 @@ mobile_app:
config: config:
default_config: default_config:
http:
use_x_forwarded_for: true
trusted_proxies:
- 192.168.86.198
# Text to speech # Text to speech
tts: tts:
- platform: google_translate - platform: google_translate
@@ -75,6 +80,9 @@ sensor:
state_topic: "house/sensor/bedroom_humidity/state" state_topic: "house/sensor/bedroom_humidity/state"
name: "Upstairs Humidity" name: "Upstairs Humidity"
unit_of_measurement: "%" unit_of_measurement: "%"
- platform: mqtt
state_topic: "house/sensor/living_room_brightness/state"
name: "Living Room Brightness"
- platform: mqtt - platform: mqtt
state_topic: "DansPhone/sleepinfo" state_topic: "DansPhone/sleepinfo"
name: "sleep Info" name: "sleep Info"

501
home-assistant.log Normal file
View File

@@ -0,0 +1,501 @@
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.components.binary_sensor] Setup of binary_sensor platform hassio is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.setup] Setup of input_number is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.setup] Setup of counter is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.setup] Setup of timer is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.setup] Setup of group is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.setup] Setup of input_boolean is taking over 10 seconds.
2021-09-06 20:50:34 WARNING (MainThread) [homeassistant.components.scene] Setup of scene platform homeassistant is taking over 10 seconds.
2021-09-06 20:50:36 ERROR (MainThread) [homeassistant.components.sensor] The sonarr platform for the sensor integration does not support platform setup. Please remove it from your config.
2021-09-06 20:50:37 WARNING (MainThread) [homeassistant.components.webhook] Received message for unregistered webhook eb9d2fbd9f8fea4200d7752b689aecfe6a2ca2215d2cbe0600b75a4fd20a6797 from 192.168.86.163
2021-09-06 20:50:46 WARNING (MainThread) [homeassistant.components.webhook] Received message for unregistered webhook eb9d2fbd9f8fea4200d7752b689aecfe6a2ca2215d2cbe0600b75a4fd20a6797 from 192.168.86.163
2021-09-06 20:51:00 WARNING (MainThread) [homeassistant.components.sensor] Setup of sensor platform mqtt is taking over 10 seconds.
2021-09-06 20:51:00 WARNING (MainThread) [homeassistant.config_entries] Config entry 'Philips hue' for hue integration not ready yet: Error connecting to the Hue bridge at 192.168.86.44; Retrying in background
2021-09-06 20:51:00 WARNING (MainThread) [homeassistant.components.climate] Setup of climate platform ecobee is taking over 10 seconds.
2021-09-06 20:51:00 WARNING (MainThread) [homeassistant.components.sensor] Setup of sensor platform template is taking over 10 seconds.
2021-09-06 20:51:00 WARNING (MainThread) [homeassistant.components.sensor] Setup of sensor platform sonarr is taking over 10 seconds.
2021-09-06 20:51:02 ERROR (MainThread) [homeassistant.components.hassio.handler] Timeout on /store request
2021-09-06 20:51:02 ERROR (MainThread) [homeassistant.components.hassio] Failed to to call /store -
2021-09-06 20:51:09 WARNING (Recorder) [homeassistant.components.recorder.migration] Database is about to upgrade. Schema version: 18
2021-09-06 20:51:09 WARNING (Recorder) [homeassistant.components.recorder.migration] Modifying columns mean, min, max, state, sum in table statistics. Note: this can take several minutes on large databases and slow computers. Please be patient!
2021-09-06 20:51:20 WARNING (MainThread) [homeassistant.components.websocket_api.http.connection] [1771879080] Disconnected: Did not receive auth message within 10 seconds
2021-09-07 00:36:26 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-07 07:54:10 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-07 07:54:10 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-07 20:31:40 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-08 06:23:06 WARNING (MainThread) [homeassistant.helpers.entity] Update of sensor.home_temperature is taking over 10 seconds
2021-09-08 11:50:29 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-08 11:50:29 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-08 21:42:07 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-10 02:33:24 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-10 02:33:24 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-10 04:34:15 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-10 15:23:16 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-10 15:23:16 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-10 22:41:08 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-11 08:52:50 ERROR (MainThread) [metno] https://aa015h6buqvih86i1.api.met.no/weatherapi/locationforecast/2.0/complete returned 503
2021-09-11 22:00:44 ERROR (Recorder) [homeassistant.components.recorder] Database connection invalidated: Error executing query: (MySQLdb._exceptions.OperationalError) (1927, 'Connection was killed')
[SQL: INSERT INTO events (event_type, event_data, origin, time_fired, created, context_id, context_user_id, context_parent_id) VALUES (%s, %s, %s, %s, %s, %s, %s, %s)]
[parameters: ('state_changed', '{}', 'LOCAL', datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), '329e51799899ed2b3ad329a46e4c07f8', None, None)]
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:00:47 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:00:44.001922-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (1927, 'Connection was killed')
[SQL: INSERT INTO events (event_type, event_data, origin, time_fired, created, context_id, context_user_id, context_parent_id) VALUES (%s, %s, %s, %s, %s, %s, %s, %s)]
[parameters: ('state_changed', '{}', 'LOCAL', datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), '329e51799899ed2b3ad329a46e4c07f8', None, None)]
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (1927, 'Connection was killed')
[SQL: INSERT INTO events (event_type, event_data, origin, time_fired, created, context_id, context_user_id, context_parent_id) VALUES (%s, %s, %s, %s, %s, %s, %s, %s)]
[parameters: ('state_changed', '{}', 'LOCAL', datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), datetime.datetime(2021, 9, 12, 2, 0, 43, 277870, tzinfo=datetime.timezone.utc), '329e51799899ed2b3ad329a46e4c07f8', None, None)]
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:00:48 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:00:51 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:00:48.001559-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:00:51 ERROR (Recorder) [homeassistant.components.recorder] Unhandled database error while processing event <Event time_changed[L]: now=2021-09-11T22:00:49.001311-04:00>: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
Traceback (most recent call last):
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
MySQLdb._exceptions.OperationalError: (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 772, in _process_one_event
self._send_keep_alive()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 911, in _send_keep_alive
self.event_session.connection().scalar(select([1]))
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1519, in connection
return self._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1529, in _connection_for_bind
return self._transaction._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 747, in _connection_for_bind
conn = bind.connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3166, in connect
return self._connection_cls(self, close_with_result=close_with_result)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 96, in __init__
else engine.raw_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3245, in raw_connection
return self._wrap_pool_connect(self.pool.connect, _connection)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3215, in _wrap_pool_connect
Connection._handle_dbapi_exception_noconnection(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 2069, in _handle_dbapi_exception_noconnection
util.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
sqlalchemy.exc.OperationalError: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
2021-09-11 22:01:02 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:01:05 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:01:02.001176-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:01:18 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:01:21 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:01:18.002334-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:01:21 ERROR (Recorder) [homeassistant.components.recorder] Unhandled database error while processing event <Event time_changed[L]: now=2021-09-11T22:01:19.001390-04:00>: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
Traceback (most recent call last):
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
MySQLdb._exceptions.OperationalError: (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 772, in _process_one_event
self._send_keep_alive()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 911, in _send_keep_alive
self.event_session.connection().scalar(select([1]))
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1519, in connection
return self._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1529, in _connection_for_bind
return self._transaction._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 747, in _connection_for_bind
conn = bind.connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3166, in connect
return self._connection_cls(self, close_with_result=close_with_result)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 96, in __init__
else engine.raw_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3245, in raw_connection
return self._wrap_pool_connect(self.pool.connect, _connection)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3215, in _wrap_pool_connect
Connection._handle_dbapi_exception_noconnection(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 2069, in _handle_dbapi_exception_noconnection
util.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
sqlalchemy.exc.OperationalError: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
2021-09-11 22:01:33 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:01:36 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:01:33.001691-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:01:48 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:01:51 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:01:48.001320-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:01:51 ERROR (Recorder) [homeassistant.components.recorder] Unhandled database error while processing event <Event time_changed[L]: now=2021-09-11T22:01:49.000976-04:00>: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
Traceback (most recent call last):
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
MySQLdb._exceptions.OperationalError: (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 772, in _process_one_event
self._send_keep_alive()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 911, in _send_keep_alive
self.event_session.connection().scalar(select([1]))
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1519, in connection
return self._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1529, in _connection_for_bind
return self._transaction._connection_for_bind(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 747, in _connection_for_bind
conn = bind.connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3166, in connect
return self._connection_cls(self, close_with_result=close_with_result)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 96, in __init__
else engine.raw_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3245, in raw_connection
return self._wrap_pool_connect(self.pool.connect, _connection)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3215, in _wrap_pool_connect
Connection._handle_dbapi_exception_noconnection(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 2069, in _handle_dbapi_exception_noconnection
util.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/base.py", line 3212, in _wrap_pool_connect
return fn()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 307, in connect
return _ConnectionFairy._checkout(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 767, in _checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 430, in checkout
rec._checkin_failed(err, _fairy_was_created=False)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 427, in checkout
dbapi_connection = rec.get_connection()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 552, in get_connection
self.__connect()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 611, in __connect
pool.logger.debug("Error on connect(): %s", e)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/langhelpers.py", line 70, in __exit__
compat.raise_(
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/util/compat.py", line 207, in raise_
raise exception
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/pool/base.py", line 605, in __connect
connection = pool._invoke_creator(self)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/create.py", line 578, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/engine/default.py", line 584, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/__init__.py", line 130, in Connect
return Connection(*args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/MySQLdb/connections.py", line 185, in __init__
super().__init__(*args, **kwargs2)
sqlalchemy.exc.OperationalError: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8)
2021-09-11 22:02:03 ERROR (Recorder) [homeassistant.components.recorder] Error in database connectivity during commit: Error executing query: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8). (retrying in 3 seconds)
2021-09-11 22:02:06 ERROR (Recorder) [homeassistant.components.recorder] SQLAlchemyError error processing event <Event time_changed[L]: now=2021-09-11T22:02:03.001368-04:00>: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 657, in _process_one_event_or_recover
self._process_one_event(event)
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 777, in _process_one_event
self._commit_event_session_or_retry()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 840, in _commit_event_session_or_retry
self._commit_event_session()
File "/usr/src/homeassistant/homeassistant/components/recorder/__init__.py", line 866, in _commit_event_session
self.event_session.commit()
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 1428, in commit
self._transaction.commit(_to_root=self.future)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 827, in commit
self._assert_active(prepared_ok=True)
File "/usr/local/lib/python3.9/site-packages/sqlalchemy/orm/session.py", line 601, in _assert_active
raise sa_exc.PendingRollbackError(
sqlalchemy.exc.PendingRollbackError: This Session's transaction has been rolled back due to a previous exception during flush. To begin a new transaction with this Session, first issue Session.rollback(). Original exception was: (MySQLdb._exceptions.OperationalError) (2002, "Can't connect to MySQL server on '192.168.86.198' (115)")
(Background on this error at: https://sqlalche.me/e/14/e3q8) (Background on this error at: https://sqlalche.me/e/14/7s2a)
2021-09-11 22:25:05 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-12 12:27:45 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-12 12:27:45 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-12 18:38:59 ERROR (SyncWorker_3) [pyecobee] Error connecting to ecobee while attempting to get thermostats. Possible connectivity outage.
2021-09-12 18:39:47 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-12 18:51:47 ERROR (SyncWorker_4) [homeassistant.components.darksky.weather] Unable to connect to Dark Sky. HTTPSConnectionPool(host='api.darksky.net', port=443): Max retries exceeded with url: /forecast/19b4b95365ea88c65b085805ef046ba0/41.469249,-81.713146?units=us&lang=en (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x66dfae08>: Failed to establish a new connection: [Errno -3] Try again'))
2021-09-12 21:35:49 ERROR (SyncWorker_4) [homeassistant.components.darksky.weather] Unable to connect to Dark Sky. HTTPSConnectionPool(host='api.darksky.net', port=443): Max retries exceeded with url: /forecast/19b4b95365ea88c65b085805ef046ba0/41.469249,-81.713146?units=us&lang=en (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x683fb898>: Failed to establish a new connection: [Errno -3] Try again'))
2021-09-12 21:36:00 ERROR (SyncWorker_5) [pyecobee] Error connecting to ecobee while attempting to get thermostats. Possible connectivity outage.
2021-09-12 22:51:00 ERROR (SyncWorker_6) [pyecobee] Error connecting to ecobee while attempting to get thermostats. Possible connectivity outage.
2021-09-12 23:32:57 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-13 03:34:39 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-13 12:19:31 WARNING (MainThread) [homeassistant.components.http.ban] Login attempt or request with invalid authentication from 119.91.96.181 (119.91.96.181). (Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/36.0.1985.125 Safari/537.36)
2021-09-13 12:30:44 ERROR (MainThread) [homeassistant.components.sonarr.sensor] Error communicating with API: Timeout occurred while connecting to API
2021-09-13 12:34:44 ERROR (MainThread) [homeassistant.components.sonarr.sensor] Error communicating with API: Timeout occurred while connecting to API
2021-09-13 16:08:18 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data
2021-09-14 03:44:55 ERROR (SyncWorker_5) [homeassistant.components.darksky.weather] Unable to connect to Dark Sky. HTTPSConnectionPool(host='api.darksky.net', port=443): Max retries exceeded with url: /forecast/19b4b95365ea88c65b085805ef046ba0/41.469249,-81.713146?units=us&lang=en (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x67098118>: Failed to establish a new connection: [Errno -3] Try again'))
2021-09-14 03:45:05 ERROR (SyncWorker_6) [pyecobee] Error connecting to ecobee while attempting to get thermostats. Possible connectivity outage.
2021-09-14 21:34:34 ERROR (MainThread) [homeassistant.components.hue.sensor_base] Timeout fetching sensor data
2021-09-14 23:16:30 ERROR (MainThread) [homeassistant.components.hue.light] Timeout fetching light data

3377
home-assistant.log.1 Normal file

File diff suppressed because it is too large Load Diff

BIN
home-assistant_v2.db Normal file

Binary file not shown.

BIN
pyozw.sqlite Normal file

Binary file not shown.

View File

@@ -9,6 +9,7 @@ views:
entity: weather.amherst entity: weather.amherst
- type: entities - type: entities
entities: entities:
- sensor.living_room_brightness
- sun.sun - sun.sun
- sensor.home_temperature - sensor.home_temperature
- sensor.home_humidity - sensor.home_humidity

BIN
zigbee.db

Binary file not shown.

99
zwcfg_0xf9bd3698.xml Normal file
View File

@@ -0,0 +1,99 @@
<?xml version="1.0" encoding="utf-8" ?>
<Driver xmlns="http://code.google.com/p/open-zwave/" version="3" home_id="0xf9bd3698" node_id="1" api_capabilities="8" controller_capabilities="28" poll_interval="30000" poll_interval_between="false">
<Node id="1" name="" location="" basic="2" generic="2" specific="1" type="Static PC Controller" listening="true" frequentListening="false" beaming="true" routing="true" max_baud_rate="40000" version="4" query_stage="Complete">
<Manufacturer id="0" name="Z-Wave (Sigma Designs)">
<Product type="1" id="1" name="UZB Z-Wave USB Adapter" />
</Manufacturer>
<CommandClasses>
<CommandClass id="32" name="COMMAND_CLASS_BASIC" version="1" after_mark="true">
<Instance index="1" />
<Value type="byte" genre="basic" instance="1" index="0" label="Basic" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="255" value="0" />
</CommandClass>
</CommandClasses>
</Node>
<Node id="2" name="" location="" basic="4" generic="16" specific="3" type="Binary Scene Switch" listening="true" frequentListening="false" beaming="true" routing="true" max_baud_rate="40000" version="4" query_stage="Complete">
<Manufacturer id="14f" name="Linear (Nortek Security Control LLC)">
<Product type="5250" id="3030" name="PS15Z-2 Plug-in Appliance Module" />
</Manufacturer>
<CommandClasses>
<CommandClass id="32" name="COMMAND_CLASS_BASIC" version="1" request_flags="4" mapping="37">
<Instance index="1" />
</CommandClass>
<CommandClass id="37" name="COMMAND_CLASS_SWITCH_BINARY" version="1" request_flags="4" innif="true">
<Instance index="1" />
<Value type="bool" genre="user" instance="1" index="0" label="Switch" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" value="True" />
</CommandClass>
<CommandClass id="39" name="COMMAND_CLASS_SWITCH_ALL" version="1" request_flags="4" innif="true">
<Instance index="1" />
<Value type="list" genre="system" instance="1" index="0" label="Switch All" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" vindex="3" size="1">
<Item label="Disabled" value="0" />
<Item label="Off Enabled" value="1" />
<Item label="On Enabled" value="2" />
<Item label="On and Off Enabled" value="255" />
</Value>
</CommandClass>
<CommandClass id="43" name="COMMAND_CLASS_SCENE_ACTIVATION" version="1" request_flags="4" innif="true">
<Instance index="1" />
</CommandClass>
<CommandClass id="112" name="COMMAND_CLASS_CONFIGURATION" version="1" request_flags="4" innif="true">
<Instance index="1" />
</CommandClass>
<CommandClass id="114" name="COMMAND_CLASS_MANUFACTURER_SPECIFIC" version="1" request_flags="4" innif="true">
<Instance index="1" />
</CommandClass>
<CommandClass id="115" name="COMMAND_CLASS_POWERLEVEL" version="1" request_flags="4" innif="true">
<Instance index="1" />
<Value type="list" genre="system" instance="1" index="0" label="Powerlevel" units="dB" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" vindex="0" size="1">
<Item label="Normal" value="0" />
<Item label="-1dB" value="1" />
<Item label="-2dB" value="2" />
<Item label="-3dB" value="3" />
<Item label="-4dB" value="4" />
<Item label="-5dB" value="5" />
<Item label="-6dB" value="6" />
<Item label="-7dB" value="7" />
<Item label="-8dB" value="8" />
<Item label="-9dB" value="9" />
</Value>
<Value type="byte" genre="system" instance="1" index="1" label="Timeout" units="seconds" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="255" value="0" />
<Value type="button" genre="system" instance="1" index="2" label="Set Powerlevel" units="" read_only="false" write_only="true" verify_changes="false" poll_intensity="0" min="0" max="0" />
<Value type="byte" genre="system" instance="1" index="3" label="Test Node" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="255" value="0" />
<Value type="list" genre="system" instance="1" index="4" label="Test Powerlevel" units="dB" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" vindex="0" size="1">
<Item label="Normal" value="0" />
<Item label="-1dB" value="1" />
<Item label="-2dB" value="2" />
<Item label="-3dB" value="3" />
<Item label="-4dB" value="4" />
<Item label="-5dB" value="5" />
<Item label="-6dB" value="6" />
<Item label="-7dB" value="7" />
<Item label="-8dB" value="8" />
<Item label="-9dB" value="9" />
</Value>
<Value type="short" genre="system" instance="1" index="5" label="Frame Count" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="-32768" max="32767" value="0" />
<Value type="button" genre="system" instance="1" index="6" label="Test" units="" read_only="false" write_only="true" verify_changes="false" poll_intensity="0" min="0" max="0" />
<Value type="button" genre="system" instance="1" index="7" label="Report" units="" read_only="false" write_only="true" verify_changes="false" poll_intensity="0" min="0" max="0" />
<Value type="list" genre="system" instance="1" index="8" label="Test Status" units="" read_only="true" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" vindex="0" size="1">
<Item label="Failed" value="0" />
<Item label="Success" value="1" />
<Item label="In Progress" value="2" />
</Value>
<Value type="short" genre="system" instance="1" index="9" label="Acked Frames" units="" read_only="true" write_only="false" verify_changes="false" poll_intensity="0" min="-32768" max="32767" value="0" />
</CommandClass>
<CommandClass id="117" name="COMMAND_CLASS_PROTECTION" version="1" request_flags="4" innif="true">
<Instance index="1" />
<Value type="list" genre="system" instance="1" index="0" label="Protection" units="" read_only="false" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" vindex="0" size="1">
<Item label="Unprotected" value="0" />
<Item label="Protection by Sequence" value="1" />
<Item label="No Operation Possible" value="2" />
</Value>
</CommandClass>
<CommandClass id="134" name="COMMAND_CLASS_VERSION" version="1" request_flags="4" innif="true">
<Instance index="1" />
<Value type="string" genre="system" instance="1" index="0" label="Library Version" units="" read_only="true" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" value="6" />
<Value type="string" genre="system" instance="1" index="1" label="Protocol Version" units="" read_only="true" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" value="3.42" />
<Value type="string" genre="system" instance="1" index="2" label="Application Version" units="" read_only="true" write_only="false" verify_changes="false" poll_intensity="0" min="0" max="0" value="5.41" />
</CommandClass>
</CommandClasses>
</Node>
</Driver>

2
zwscene.xml Normal file
View File

@@ -0,0 +1,2 @@
<?xml version="1.0" encoding="utf-8" ?>
<Scenes xmlns="http://code.google.com/p/open-zwave/" version="1" />