Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Waking up sleeping devices #279

Closed
croszatycki opened this issue Apr 1, 2019 · 1 comment
Closed

Waking up sleeping devices #279

croszatycki opened this issue Apr 1, 2019 · 1 comment

Comments

@croszatycki
Copy link

croszatycki commented Apr 1, 2019

I have few z-wave devices from different manufactures, working on batteries:

  1. Z-Wave dongle: Aeotec - Z-Stick Gen5 (Model: ZW090-A), pluged into usb
  2. Door/Window sensor: Aeotec Sensor Gen5 (Model: ZW120-A)
  3. Door/Window sensor: Ecolink (Model: DW-ZWAVE2.5-ECO)
  4. Multi Sensor: Aeotec MultiSensor 6 (Model: ZW100-A)

Problem is that: after each starting nodejs application, nodes are in sleeping mode. There is no way to wake them up from software, nodes are not waking up even after setting WAKE_UP interval time.

I tried also other solutions from other issues #46 #249 Nothing helps

Initialising OpenZWave 1.4.1 binary addon for Node.JS.
	OpenZWave Security API is ENABLED
	ZWave device db    : /usr/local/etc/openzwave/
	User settings path : /home/pi/zs-iot.new/node_modules/openzwave-shared/build/Release/../../
	Option Overrides : --ConsoleOutput true --AssumeAwake true --SaveConfiguration true
2019-03-31 23:43:59.868 Always, OpenZwave Version 1.4.1 Starting Up
2019-03-31 23:43:59.870 Info, Setting Up Provided Network Key for Secure Communications
2019-03-31 23:43:59.871 Info, mgr,     Added driver for controller /dev/ttyACM0
2019-03-31 23:43:59.871 Info,   Opening controller /dev/ttyACM0
2019-03-31 23:43:59.871 Info, Trying to open serial port /dev/ttyACM0 (attempt 1)
2019-03-31 23:43:59.872 Info, Serial port /dev/ttyACM0 opened (attempt 1)
2019-03-31 23:43:59.873 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2019-03-31 23:43:59.874 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2019-03-31 23:43:59.874 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2019-03-31 23:43:59.874 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2019-03-31 23:43:59.874 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2019-03-31 23:43:59.875 Detail, 
2019-03-31 23:43:59.875 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2019-03-31 23:43:59.878 Detail, contrlr,   Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x35, 0x34, 0x00, 0x01, 0x93
2019-03-31 23:43:59.878 Detail, 
2019-03-31 23:43:59.878 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2019-03-31 23:43:59.878 Info, contrlr,     Static Controller library, version Z-Wave 4.54
2019-03-31 23:43:59.879 Detail, Node045,   Expected reply was received
2019-03-31 23:43:59.879 Detail, Node045,   Message transaction complete
2019-03-31 23:43:59.879 Detail, 
2019-03-31 23:43:59.879 Detail, contrlr, Removing current message
2019-03-31 23:43:59.879 Detail, 
2019-03-31 23:43:59.880 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2019-03-31 23:43:59.883 Detail, contrlr,   Received: 0x01, 0x08, 0x01, 0x20, 0xf5, 0xb5, 0x33, 0xd0, 0x01, 0x74
2019-03-31 23:43:59.883 Detail, 
2019-03-31 23:43:59.883 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xf5b533d0.  Our node ID = 1
2019-03-31 23:43:59.884 Detail, Node181,   Expected reply was received
2019-03-31 23:43:59.884 Detail, Node181,   Message transaction complete
2019-03-31 23:43:59.884 Detail, 
2019-03-31 23:43:59.884 Detail, contrlr, Removing current message
2019-03-31 23:43:59.884 Detail, 
2019-03-31 23:43:59.884 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2019-03-31 23:43:59.887 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x05, 0x08, 0xf7
2019-03-31 23:43:59.887 Detail, 
2019-03-31 23:43:59.887 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2019-03-31 23:43:59.887 Info, contrlr,     There is no SUC ID Server (SIS) in this network.
2019-03-31 23:43:59.887 Info, contrlr,     The PC controller is a primary controller.
2019-03-31 23:43:59.888 Detail, Node247,   Expected reply was received
2019-03-31 23:43:59.888 Detail, Node247,   Message transaction complete
2019-03-31 23:43:59.888 Detail, 
2019-03-31 23:43:59.888 Detail, contrlr, Removing current message
2019-03-31 23:43:59.888 Detail, 
2019-03-31 23:43:59.888 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2019-03-31 23:43:59.893 Detail, contrlr,   Received: 0x01, 0x2b, 0x01, 0x07, 0x01, 0x01, 0x00, 0x86, 0x01, 0x01, 0x00, 0x5a, 0xfe, 0x81, 0xff, 0x88, 0x4f, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x00, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0xfb
2019-03-31 23:43:59.893 Detail, 
2019-03-31 23:43:59.894 Info, contrlr,  Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2019-03-31 23:43:59.894 Info, contrlr,     Serial API Version:   1.1
2019-03-31 23:43:59.894 Info, contrlr,     Manufacturer ID:      0x0086
2019-03-31 23:43:59.894 Info, contrlr,     Product Type:         0x0101
2019-03-31 23:43:59.894 Info, contrlr,     Product ID:           0x005a
2019-03-31 23:43:59.895 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2019-03-31 23:43:59.895 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2019-03-31 23:43:59.895 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2019-03-31 23:43:59.895 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2019-03-31 23:43:59.895 Detail, Node001,   Expected reply was received
2019-03-31 23:43:59.895 Detail, Node001,   Message transaction complete
2019-03-31 23:43:59.896 Detail, 
2019-03-31 23:43:59.896 Detail, contrlr, Removing current message
2019-03-31 23:43:59.896 Detail, 
2019-03-31 23:43:59.896 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2019-03-31 23:43:59.899 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac
2019-03-31 23:43:59.899 Detail, 
2019-03-31 23:43:59.900 Info, contrlr, Received reply to GET_SUC_NODE_ID.  Node ID = 0
2019-03-31 23:43:59.900 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node
2019-03-31 23:43:59.900 Detail, Node172,   Expected reply was received
2019-03-31 23:43:59.900 Detail, Node172,   Message transaction complete
2019-03-31 23:43:59.900 Detail, 
2019-03-31 23:43:59.900 Detail, contrlr, Removing current message
2019-03-31 23:43:59.901 Detail, 
2019-03-31 23:43:59.901 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2019-03-31 23:43:59.957 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0xd2, 0xb1, 0xcd, 0xba, 0x6d, 0x6c, 0x0a, 0xe1, 0xbe, 0x2f, 0xdc, 0x71, 0x0a, 0x29, 0xbc, 0xe7, 0x22, 0x24, 0x8b, 0x4b, 0x5e, 0x0b, 0x38, 0x1a, 0x3b, 0xf3, 0x4f, 0x68, 0x86, 0x9c, 0xa4, 0x6a, 0xd6
2019-03-31 23:43:59.958 Detail, 
2019-03-31 23:43:59.958 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true
2019-03-31 23:43:59.958 Detail, Node032,   Expected reply was received
2019-03-31 23:43:59.958 Detail, Node032,   Message transaction complete
2019-03-31 23:43:59.958 Detail, 
2019-03-31 23:43:59.959 Detail, contrlr, Removing current message
2019-03-31 23:43:59.959 Detail, 
2019-03-31 23:43:59.959 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2019-03-31 23:44:00.062 Detail, contrlr,   Received: 0x01, 0x25, 0x01, 0x02, 0x05, 0x00, 0x1d, 0x71, 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, 0xb5
2019-03-31 23:44:00.063 Detail, 
2019-03-31 23:44:00.063 Info, mgr,     Driver with Home ID of 0xf5b533d0 is now ready.
2019-03-31 23:44:00.063 Info, 
2019-03-31 23:44:00.063 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
2019-03-31 23:44:00.063 Info, contrlr,     Node 001 - New
2019-03-31 23:44:00.064 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
2019-03-31 23:44:00.064 Detail, Node001, QueryStage_ProtocolInfo
2019-03-31 23:44:00.064 Detail, Node001, Queuing (Query) Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb
2019-03-31 23:44:00.064 Detail, Node001, Queuing (Query) Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.064 Info, Node001, Initilizing Node. New Node: false (false)
2019-03-31 23:44:00.065 Info, contrlr,     Node 005 - New
2019-03-31 23:44:00.065 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
2019-03-31 23:44:00.065 Detail, Node005, QueryStage_ProtocolInfo
2019-03-31 23:44:00.065 Detail, Node005, Queuing (Query) Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
2019-03-31 23:44:00.065 Detail, Node005, Queuing (Query) Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.065 Info, Node005, Initilizing Node. New Node: false (false)
2019-03-31 23:44:00.066 Info, contrlr,     Node 006 - New
2019-03-31 23:44:00.066 Detail, Node006, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
2019-03-31 23:44:00.066 Detail, Node006, QueryStage_ProtocolInfo
2019-03-31 23:44:00.066 Detail, Node006, Queuing (Query) Get Node Protocol Info (Node=6): 0x01, 0x04, 0x00, 0x41, 0x06, 0xbc
2019-03-31 23:44:00.066 Detail, Node006, Queuing (Query) Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.066 Info, Node006, Initilizing Node. New Node: false (false)
2019-03-31 23:44:00.067 Info, contrlr,     Node 007 - New
2019-03-31 23:44:00.067 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=None live=1
2019-03-31 23:44:00.067 Detail, Node007, QueryStage_ProtocolInfo
2019-03-31 23:44:00.067 Detail, Node007, Queuing (Query) Get Node Protocol Info (Node=7): 0x01, 0x04, 0x00, 0x41, 0x07, 0xbd
2019-03-31 23:44:00.067 Detail, Node007, Queuing (Query) Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.067 Info, Node007, Initilizing Node. New Node: false (false)
2019-03-31 23:44:00.068 Detail,   Expected reply was received
2019-03-31 23:44:00.068 Detail,   Message transaction complete
2019-03-31 23:44:00.068 Detail, 
2019-03-31 23:44:00.068 Detail, contrlr, Removing current message
2019-03-31 23:44:00.068 Detail, Node001, Notification: DriverReady
2019-03-31 23:44:00.069 Detail, Node001, Notification: NodeNew
2019-03-31 23:44:00.069 Detail, Node001, Notification: NodeAdded
2019-03-31 23:44:00.069 Detail, Node005, Notification: NodeNew
2019-03-31 23:44:00.069 Detail, Node005, Notification: NodeAdded
2019-03-31 23:44:00.069 Detail, Node006, Notification: NodeNew
2019-03-31 23:44:00.069 Detail, Node006, Notification: NodeAdded
2019-03-31 23:44:00.070 Detail, Node007, Notification: NodeNew
2019-03-31 23:44:00.070 Detail, Node007, Notification: NodeAdded
2019-03-31 23:44:00.070 Detail, 
2019-03-31 23:44:00.070 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2019-03-31 23:44:00.075 Detail, contrlr,   Received: 0x01, 0x05, 0x01, 0x06, 0x64, 0x0f, 0x96
2019-03-31 23:44:00.076 Detail, 
2019-03-31 23:44:00.076 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
2019-03-31 23:44:00.076 Detail, Node015,   Expected reply was received
2019-03-31 23:44:00.076 Detail, Node015,   Message transaction complete
2019-03-31 23:44:00.076 Detail, 
2019-03-31 23:44:00.076 Detail, contrlr, Removing current message
2019-03-31 23:44:00.077 Detail, 
2019-03-31 23:44:00.077 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
2019-03-31 23:44:00.079 Detail, contrlr, Removing current message
2019-03-31 23:44:00.079 Detail, 
2019-03-31 23:44:00.080 Info, Node001, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=1): 0x01, 0x04, 0x00, 0x41, 0x01, 0xbb
2019-03-31 23:44:00.083 Detail, Node001,   Received: 0x01, 0x09, 0x01, 0x41, 0x93, 0x16, 0x01, 0x02, 0x02, 0x01, 0x33
2019-03-31 23:44:00.083 Detail, 
2019-03-31 23:44:00.084 Info, Node001, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
2019-03-31 23:44:00.084 Info, Node001,   Protocol Info for Node 1:
2019-03-31 23:44:00.084 Info, Node001,     Listening     = true
2019-03-31 23:44:00.084 Info, Node001,     Beaming       = true
2019-03-31 23:44:00.084 Info, Node001,     Routing       = false
2019-03-31 23:44:00.084 Info, Node001,     Max Baud Rate = 40000
2019-03-31 23:44:00.084 Info, Node001,     Version       = 4
2019-03-31 23:44:00.085 Info, Node001,     Security      = false
2019-03-31 23:44:00.103 Info, Node001,   Basic device class    (0x02) - Static Controller
2019-03-31 23:44:00.103 Info, Node001,   Generic device Class  (0x02) - Static Controller
2019-03-31 23:44:00.103 Info, Node001,   Specific device class (0x01) - Static PC Controller
2019-03-31 23:44:00.103 Info, Node001,     COMMAND_CLASS_BASIC is not mapped
2019-03-31 23:44:00.104 Info, Node001,   Mandatory Command Classes for Node 1:
2019-03-31 23:44:00.104 Info, Node001,     None
2019-03-31 23:44:00.104 Info, Node001,   Mandatory Command Classes controlled by Node 1:
2019-03-31 23:44:00.104 Info, Node001,     COMMAND_CLASS_BASIC
2019-03-31 23:44:00.105 Detail, Node022,   Expected reply was received
2019-03-31 23:44:00.105 Detail, Node022,   Message transaction complete
2019-03-31 23:44:00.105 Detail, 
2019-03-31 23:44:00.105 Detail, Node001, Removing current message
2019-03-31 23:44:00.105 Detail, Node001, Notification: NodeProtocolInfo
2019-03-31 23:44:00.105 Detail, Node001, Notification: ValueAdded
2019-03-31 23:44:00.106 Detail, Node001, Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.106 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
2019-03-31 23:44:00.106 Detail, Node001, QueryStage_Probe
2019-03-31 23:44:00.106 Detail, Node001, QueryStage_WakeUp
2019-03-31 23:44:00.106 Detail, Node001, QueryStage_ManufacturerSpecific1
2019-03-31 23:44:00.106 Detail, Node001, Load Controller Manufacturer Specific Config
ZenSpace IoT Server listening on port 3000!
2019-03-31 23:44:00.149 Info, Node001,   Opening config param file /usr/local/etc/openzwave/aeotec/zstickgen5.xml
2019-03-31 23:44:00.156 Detail, Node001, QueryStage_NodePlusInfo
2019-03-31 23:44:00.157 Detail, Node001, QueryStage_SecurityReport
2019-03-31 23:44:00.157 Detail, Node001, QueryStage_ManufacturerSpecific2
2019-03-31 23:44:00.157 Detail, Node001, QueryStage_Versions
2019-03-31 23:44:00.157 Detail, Node001, QueryStage_Instances
2019-03-31 23:44:00.157 Info, Node001, Essential node queries are complete
2019-03-31 23:44:00.157 Detail, Node001, QueryStage_Static
2019-03-31 23:44:00.158 Detail, Node001, QueryStage_Associations
2019-03-31 23:44:00.158 Detail, Node001, QueryStage_Neighbors
2019-03-31 23:44:00.158 Detail, Requesting routing info (neighbor list) for Node 1
2019-03-31 23:44:00.158 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2019-03-31 23:44:00.158 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
2019-03-31 23:44:00.159 Detail, Node001, Notification: EssentialNodeQueriesComplete
2019-03-31 23:44:00.159 Detail, 
2019-03-31 23:44:00.159 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
2019-03-31 23:44:00.164 Detail, Node001,   Received: 0x01, 0x20, 0x01, 0x80, 0x70, 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, 0x2e
2019-03-31 23:44:00.164 Detail, 
2019-03-31 23:44:00.164 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2019-03-31 23:44:00.164 Info, Node001,     Neighbors of this node are:
2019-03-31 23:44:00.165 Info, Node001,     Node 5
2019-03-31 23:44:00.165 Info, Node001,     Node 6
2019-03-31 23:44:00.165 Info, Node001,     Node 7
2019-03-31 23:44:00.165 Detail,   Expected reply was received
2019-03-31 23:44:00.165 Detail,   Message transaction complete
2019-03-31 23:44:00.165 Detail, 
2019-03-31 23:44:00.165 Detail, Node001, Removing current message
2019-03-31 23:44:00.166 Detail, 
2019-03-31 23:44:00.166 Info, Node005, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=5): 0x01, 0x04, 0x00, 0x41, 0x05, 0xbf
2019-03-31 23:44:00.168 Detail, Node005,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
2019-03-31 23:44:00.169 Detail, 
2019-03-31 23:44:00.169 Info, Node005, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
2019-03-31 23:44:00.169 Info, Node005,   Protocol Info for Node 5:
2019-03-31 23:44:00.169 Info, Node005,     Listening     = false
2019-03-31 23:44:00.169 Info, Node005,     Frequent      = false
2019-03-31 23:44:00.169 Info, Node005,     Beaming       = true
2019-03-31 23:44:00.170 Info, Node005,     Routing       = true
2019-03-31 23:44:00.170 Info, Node005,     Max Baud Rate = 40000
2019-03-31 23:44:00.170 Info, Node005,     Version       = 4
2019-03-31 23:44:00.170 Info, Node005,     Security      = false
2019-03-31 23:44:00.170 Info, Node005,   Basic device class    (0x04) - Routing Slave
2019-03-31 23:44:00.170 Info, Node005,   Generic device Class  (0x07) - Notification Sensor
2019-03-31 23:44:00.170 Info, Node005,   Specific device class (0x01) - Notification Sensor
2019-03-31 23:44:00.171 Info, Node005,     COMMAND_CLASS_BASIC is not mapped
2019-03-31 23:44:00.171 Info, Node005,   Mandatory Command Classes for Node 5:
2019-03-31 23:44:00.171 Info, Node005,     COMMAND_CLASS_BASIC
2019-03-31 23:44:00.171 Info, Node005,     COMMAND_CLASS_WAKE_UP
2019-03-31 23:44:00.171 Info, Node005,   Mandatory Command Classes controlled by Node 5:
2019-03-31 23:44:00.172 Info, Node005,     None
2019-03-31 23:44:00.172 Detail, Node156,   Expected reply was received
2019-03-31 23:44:00.172 Detail, Node156,   Message transaction complete
2019-03-31 23:44:00.172 Detail, 
2019-03-31 23:44:00.172 Detail, Node005, Removing current message
2019-03-31 23:44:00.172 Detail, Node005, Notification: NodeProtocolInfo
2019-03-31 23:44:00.172 Detail, Node005, Notification: ValueAdded
2019-03-31 23:44:00.173 Detail, Node005, Notification: ValueAdded
2019-03-31 23:44:00.173 Detail, Node005, Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:00.173 Detail, Node005, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
2019-03-31 23:44:00.173 Detail, Node005, QueryStage_Probe
2019-03-31 23:44:00.173 Info, Node005, NoOperation::Set - Routing=true
2019-03-31 23:44:00.174 Detail, Node005, Queuing (NoOp) NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xcd
2019-03-31 23:44:00.174 Detail, Node005, Queuing (Query) Query Stage Complete (Probe)
2019-03-31 23:44:00.174 Detail, 
2019-03-31 23:44:00.174 Info, Node005, Sending (NoOp) message (Callback ID=0x0a, Expected Reply=0x13) - NoOperation_Set (Node=5): 0x01, 0x09, 0x00, 0x13, 0x05, 0x02, 0x00, 0x00, 0x25, 0x0a, 0xcd
2019-03-31 23:44:00.182 Detail, Node005,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-03-31 23:44:00.183 Detail, Node005,   ZW_SEND_DATA delivered to Z-Wave stack
2019-03-31 23:44:04.398 Detail, Node005,   Received: 0x01, 0x07, 0x00, 0x13, 0x0a, 0x01, 0x01, 0xa6, 0x47
2019-03-31 23:44:04.398 Detail, Node005,   ZW_SEND_DATA Request with callback ID 0x0a received (expected 0x0a)
2019-03-31 23:44:04.398 Info, Node005, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2019-03-31 23:44:04.398 Info, Node005,   Node 5 has been marked as asleep
2019-03-31 23:44:04.399 Info, Node005, Node not responding - moving QueryStageComplete command to Wake-Up queue
2019-03-31 23:44:04.399 Detail, Node005, Notification: Notification - NoOperation
2019-03-31 23:44:04.399 Detail, Node005, Notification: Notification - Node Asleep
2019-03-31 23:44:04.400 Detail, 
2019-03-31 23:44:04.400 Info, Node006, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=6): 0x01, 0x04, 0x00, 0x41, 0x06, 0xbc
2019-03-31 23:44:04.403 Detail, Node006,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x07, 0x01, 0x7a
2019-03-31 23:44:04.403 Detail, 
2019-03-31 23:44:04.403 Info, Node006, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
2019-03-31 23:44:04.403 Info, Node006,   Protocol Info for Node 6:
2019-03-31 23:44:04.404 Info, Node006,     Listening     = false
2019-03-31 23:44:04.404 Info, Node006,     Frequent      = false
2019-03-31 23:44:04.404 Info, Node006,     Beaming       = true
2019-03-31 23:44:04.404 Info, Node006,     Routing       = true
2019-03-31 23:44:04.404 Info, Node006,     Max Baud Rate = 40000
2019-03-31 23:44:04.404 Info, Node006,     Version       = 4
2019-03-31 23:44:04.404 Info, Node006,     Security      = false
2019-03-31 23:44:04.405 Info, Node006,   Basic device class    (0x04) - Routing Slave
2019-03-31 23:44:04.405 Info, Node006,   Generic device Class  (0x07) - Notification Sensor
2019-03-31 23:44:04.405 Info, Node006,   Specific device class (0x01) - Notification Sensor
2019-03-31 23:44:04.405 Info, Node006,     COMMAND_CLASS_BASIC is not mapped
2019-03-31 23:44:04.405 Info, Node006,   Mandatory Command Classes for Node 6:
2019-03-31 23:44:04.406 Info, Node006,     COMMAND_CLASS_BASIC
2019-03-31 23:44:04.406 Info, Node006,     COMMAND_CLASS_WAKE_UP
2019-03-31 23:44:04.406 Info, Node006,   Mandatory Command Classes controlled by Node 6:
2019-03-31 23:44:04.406 Info, Node006,     None
2019-03-31 23:44:04.406 Detail, Node156,   Expected reply was received
2019-03-31 23:44:04.406 Detail, Node156,   Message transaction complete
2019-03-31 23:44:04.406 Detail, 
2019-03-31 23:44:04.407 Detail, Node006, Removing current message
2019-03-31 23:44:04.407 Detail, Node006, Notification: NodeProtocolInfo
2019-03-31 23:44:04.407 Detail, Node006, Notification: ValueAdded
2019-03-31 23:44:04.407 Detail, Node006, Notification: ValueAdded
2019-03-31 23:44:04.408 Detail, Node006, Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:04.408 Detail, Node006, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
2019-03-31 23:44:04.409 Detail, Node006, QueryStage_Probe
2019-03-31 23:44:04.409 Info, Node006, NoOperation::Set - Routing=true
2019-03-31 23:44:04.409 Detail, Node006, Queuing (NoOp) NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0b, 0xcf
2019-03-31 23:44:04.410 Detail, Node006, Queuing (Query) Query Stage Complete (Probe)
2019-03-31 23:44:04.410 Detail, 
2019-03-31 23:44:04.410 Info, Node006, Sending (NoOp) message (Callback ID=0x0b, Expected Reply=0x13) - NoOperation_Set (Node=6): 0x01, 0x09, 0x00, 0x13, 0x06, 0x02, 0x00, 0x00, 0x25, 0x0b, 0xcf
2019-03-31 23:44:04.422 Detail, Node006,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-03-31 23:44:04.422 Detail, Node006,   ZW_SEND_DATA delivered to Z-Wave stack
2019-03-31 23:44:08.535 Detail, Node006,   Received: 0x01, 0x07, 0x00, 0x13, 0x0b, 0x01, 0x01, 0x9c, 0x7c
2019-03-31 23:44:08.535 Detail, Node006,   ZW_SEND_DATA Request with callback ID 0x0b received (expected 0x0b)
2019-03-31 23:44:08.536 Info, Node006, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2019-03-31 23:44:08.536 Info, Node006,   Node 6 has been marked as asleep
2019-03-31 23:44:08.536 Info, Node006, Node not responding - moving QueryStageComplete command to Wake-Up queue
2019-03-31 23:44:08.537 Detail, Node006, Notification: Notification - NoOperation
2019-03-31 23:44:08.537 Detail, Node006, Notification: Notification - Node Asleep
2019-03-31 23:44:08.537 Detail, 
2019-03-31 23:44:08.538 Info, Node007, Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=7): 0x01, 0x04, 0x00, 0x41, 0x07, 0xbd
2019-03-31 23:44:08.541 Detail, Node007,   Received: 0x01, 0x09, 0x01, 0x41, 0x53, 0x9c, 0x01, 0x04, 0x21, 0x01, 0x5c
2019-03-31 23:44:08.541 Detail, 
2019-03-31 23:44:08.541 Info, Node007, Received reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO
2019-03-31 23:44:08.542 Info, Node007,   Protocol Info for Node 7:
2019-03-31 23:44:08.542 Info, Node007,     Listening     = false
2019-03-31 23:44:08.542 Info, Node007,     Frequent      = false
2019-03-31 23:44:08.543 Info, Node007,     Beaming       = true
2019-03-31 23:44:08.543 Info, Node007,     Routing       = true
2019-03-31 23:44:08.543 Info, Node007,     Max Baud Rate = 40000
2019-03-31 23:44:08.543 Info, Node007,     Version       = 4
2019-03-31 23:44:08.544 Info, Node007,     Security      = false
2019-03-31 23:44:08.544 Info, Node007,   Basic device class    (0x04) - Routing Slave
2019-03-31 23:44:08.544 Info, Node007,   Generic device Class  (0x21) - Multilevel Sensor
2019-03-31 23:44:08.545 Info, Node007,   Specific device class (0x01) - Routing Multilevel Sensor
2019-03-31 23:44:08.545 Info, Node007,     COMMAND_CLASS_BASIC will be mapped to COMMAND_CLASS_SENSOR_MULTILEVEL
2019-03-31 23:44:08.545 Info, Node007,   Mandatory Command Classes for Node 7:
2019-03-31 23:44:08.546 Info, Node007,     COMMAND_CLASS_SENSOR_MULTILEVEL
2019-03-31 23:44:08.546 Info, Node007,     COMMAND_CLASS_WAKE_UP
2019-03-31 23:44:08.546 Info, Node007,   Mandatory Command Classes controlled by Node 7:
2019-03-31 23:44:08.547 Info, Node007,     COMMAND_CLASS_BASIC
2019-03-31 23:44:08.547 Detail, Node156,   Expected reply was received
2019-03-31 23:44:08.547 Detail, Node156,   Message transaction complete
2019-03-31 23:44:08.548 Detail, 
2019-03-31 23:44:08.548 Detail, Node007, Removing current message
2019-03-31 23:44:08.548 Detail, Node007, Notification: NodeProtocolInfo
2019-03-31 23:44:08.549 Detail, Node007, Notification: ValueAdded
2019-03-31 23:44:08.549 Detail, Node007, Query Stage Complete (ProtocolInfo)
2019-03-31 23:44:08.549 Detail, Node007, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1
2019-03-31 23:44:08.550 Detail, Node007, QueryStage_Probe
2019-03-31 23:44:08.550 Info, Node007, NoOperation::Set - Routing=true
2019-03-31 23:44:08.550 Detail, Node007, Queuing (NoOp) NoOperation_Set (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x00, 0x00, 0x25, 0x0c, 0xc9
2019-03-31 23:44:08.551 Detail, Node007, Queuing (Query) Query Stage Complete (Probe)
2019-03-31 23:44:08.551 Detail, 
2019-03-31 23:44:08.551 Info, Node007, Sending (NoOp) message (Callback ID=0x0c, Expected Reply=0x13) - NoOperation_Set (Node=7): 0x01, 0x09, 0x00, 0x13, 0x07, 0x02, 0x00, 0x00, 0x25, 0x0c, 0xc9
2019-03-31 23:44:08.561 Detail, Node007,   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-03-31 23:44:08.561 Detail, Node007,   ZW_SEND_DATA delivered to Z-Wave stack
2019-03-31 23:44:12.849 Detail, Node007,   Received: 0x01, 0x07, 0x00, 0x13, 0x0c, 0x01, 0x01, 0xad, 0x4a
2019-03-31 23:44:12.849 Detail, Node007,   ZW_SEND_DATA Request with callback ID 0x0c received (expected 0x0c)
2019-03-31 23:44:12.850 Info, Node007, WARNING: ZW_SEND_DATA failed. No ACK received - device may be asleep.
2019-03-31 23:44:12.850 Info, Node007,   Node 7 has been marked as asleep
2019-03-31 23:44:12.850 Info, Node007, Node not responding - moving QueryStageComplete command to Wake-Up queue
2019-03-31 23:44:12.851 Detail, Node007, Notification: Notification - NoOperation
2019-03-31 23:44:12.851 Detail, Node007, Notification: Notification - Node Asleep
2019-03-31 23:44:12.851 Detail, Node001, Query Stage Complete (Neighbors)
2019-03-31 23:44:12.852 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2019-03-31 23:44:12.852 Detail, Node001, QueryStage_Session
2019-03-31 23:44:12.852 Detail, Node001, QueryStage_Dynamic
2019-03-31 23:44:12.853 Detail, Node001, QueryStage_Configuration
2019-03-31 23:44:12.853 Detail, Node001, QueryStage_Complete
2019-03-31 23:44:12.853 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2019-03-31 23:44:12.854 Warning, CheckCompletedNodeQueries all=0, deadFound=0 sleepingOnly=1
2019-03-31 23:44:12.854 Info,          Node query processing complete except for sleeping nodes.
2019-03-31 23:44:12.854 Detail, Node001, Notification: NodeQueriesComplete
2019-03-31 23:44:12.855 Detail, contrlr, Notification: AwakeNodesQueried

And here I changed door/window sensors state by bringing closer and moving away magnet

2019-03-31 23:44:59.761 Detail, Node006,   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x06, 0x03, 0x20, 0x01, 0xff, 0x29
2019-03-31 23:44:59.761 Detail, 
2019-03-31 23:44:59.762 Info, Node006, Received Basic set from node 6: level=255.  Sending event notification.
2019-03-31 23:44:59.762 Detail, Node006, Notification: NodeEvent
2019-03-31 23:44:59.812 Detail, Node006,   Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x06, 0x0a, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x16, 0x00, 0x00, 0x7c
2019-03-31 23:44:59.813 Detail, 
2019-03-31 23:44:59.813 Info, Node006, ApplicationCommandHandler - Unhandled Command Class 0x71
2019-03-31 23:45:06.959 Detail, Node005,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x05, 0x0b, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x16, 0x00, 0x00, 0x00, 0x7f
2019-03-31 23:45:06.959 Detail, 
2019-03-31 23:45:06.960 Info, Node005, ApplicationCommandHandler - Unhandled Command Class 0x71
2019-03-31 23:45:06.981 Detail, Node005,   Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x05, 0x04, 0x30, 0x03, 0xff, 0xff, 0xc3
2019-03-31 23:45:06.981 Detail, 
2019-03-31 23:45:06.981 Info, Node005, ApplicationCommandHandler - Unhandled Command Class 0x30
2019-03-31 23:45:07.305 Detail, Node005,   Received: 0x01, 0x11, 0x00, 0x04, 0x00, 0x05, 0x0b, 0x71, 0x05, 0x00, 0x00, 0x00, 0xff, 0x06, 0x17, 0x00, 0x00, 0x00, 0x7e
2019-03-31 23:45:07.305 Detail, 
2019-03-31 23:45:07.305 Info, Node005, ApplicationCommandHandler - Unhandled Command Class 0x71
2019-03-31 23:45:07.326 Detail, Node005,   Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x05, 0x04, 0x30, 0x03, 0x00, 0xff, 0x3c
2019-03-31 23:45:07.326 Detail, 
2019-03-31 23:45:07.326 Info, Node005, ApplicationCommandHandler - Unhandled Command Class 0x30

When I wake up devices manually, for example by hitting button or removing cover (cover also triggers action by releasing some switch) devices are waking up, and classes appears in list.

After that, above command classes are not longer unhandled

MulitSensor can work in wire mode (power over usb), after giving power by wire I have no issues with that sensor, it not proceeds to sleep mode.

I tested those sensors with Samsung SmartThings hub, this issue not appears on it

@ekarak
Copy link
Member

ekarak commented May 19, 2019

The ZWave controller stick has no way to wake up battery-powered devices. They would need to listen on the radio interface, hence consume power, and you'd be changing batteries every couple of weeks.

@ekarak ekarak closed this as completed May 19, 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants