While it’s a little hard to be sure from this log, it looks like the device has not been discovered yet. There is no device information available, and until the binding receives this from the device it will not be able to do anything.
I guess this is a battery device, and you should wake it up so that the binding can discovery it fully and then configure it.
It may also help to press the button 3x times quickly (LED will flash than instead of a one-time-blink). Actually 3x press is for in-/exclusion, but if the controller is not in in-/exclusion mode nothing will happen regarding that, but might help to initiate data transfer.
Also give it some time between experiments with trying to wake it up.
For the 1x click at least 30 seconds, for the 3x click at least a minute.
Removing the battery is also an option - give the sensor then 15 seconds (I believe) to start up.
I have 7 of these, and sometimes they included & transferred instantly, and something it was a longer process with many tries.
Also, when it was very rebellious to recognise, restarting OH can help - again, give OH then some time to fully startup - when the messaging frequency in the controller frame count reduces, try the usual one-click method to wake the sensor.
Once included and configured, the sensors are very reliable in operation, the hardware is very good, despite the low price.
Edit: Also read here: Neo Coolcam PIR motion sensor (PD03Z) - Wakeup issue
Edit: Just in case: The 1x click must not be too short. Something like a 0.1-second-click does nothing, but a 0.3-second-click works. If you don’t see the LED blink one time, it was too short pressed.
Hi,
i have the same Problem with two new Neo Coolcam NAS-PD01Z.
Both Devices I can include in the OpenHAB Z-Wave network and Openhab will identify them correctly.
However if I Wakeup the Devices, I see nothing in the OpenHAB Z-Wave (Debug) log for a Wakeup…
Also I can’t change any settings like Assoziation Group etc., because the devices send no Wakeup Notivication to the controller? In Paper UI there is a point to Setup „Wakeup Configuration“ - „WakeupNode“. This is empty after the Inclution.
In the Userdata/zwave folder also no xml files created.
The Devices will blink red if they notivacate any motion, however send nothing to the Controller.
I already thry 3x click, without any luck.
Platform information:
Different device so different issue with similar symptoms.
Please start a new thread to avoid dealing with multiple problems in the same thread.
The volunteers here are easily confused.
thanks Cris i will continue to try and give it some more time today. Have any of these, in your experience, taken more than a day to get discovered?
I found that clicking the button 3x will force awake up. So that is good. I see in the log that it shows node10 is updated but there still isn’t a xml for this node in the $OPENHAB_USERDATA/zwave folder. I’ve done this every few minutes for about an hour.
2020-05-06 09:27:47.104 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0A 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 4A
2020-05-06 09:27:47.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70
2020-05-06 09:27:47.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70
2020-05-06 09:27:47.137 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2020-05-06 09:27:47.140 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2020-05-06 09:27:47.142 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2020-05-06 09:27:47.148 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=10, callback=132, payload=84 0A 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70
2020-05-06 09:27:47.151 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 10: Application update request. Node information received. Transaction null
2020-05-06 09:27:47.154 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 10: Application update - no transaction.
2020-05-06 09:27:47.157 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.160 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-05-06 09:27:47.164 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0A 03 86 13 73 25 7C 50
2020-05-06 09:27:47.169 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 10: Sending REQUEST Message = 01 0A 00 13 0A 03 86 13 73 25 7C 50
2020-05-06 09:27:47.172 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-05-06 09:27:47.174 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-05-06 09:27:47.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:47.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:47.184 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.186 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2020-05-06 09:27:47.186 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-05-06 09:27:47.189 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:47.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:47.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.200 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.201 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7C 00 00 02 95
2020-05-06 09:27:47.201 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: sentData successfully placed on stack.
2020-05-06 09:27:47.203 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 144: Advanced to WAIT_REQUEST
2020-05-06 09:27:47.205 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 144: Transaction not completed
2020-05-06 09:27:47.205 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=124, payload=7C 00 00 02
2020-05-06 09:27:47.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:47.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=124, payload=7C 00 00 02
2020-05-06 09:27:47.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.213 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 0A 04 86 14 73 01 1F
2020-05-06 09:27:47.213 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:47.215 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 144: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 124
2020-05-06 09:27:47.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 144: (Callback 124)
2020-05-06 09:27:47.218 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=10, callback=0, payload=00 0A 04 86 14 73 01
2020-05-06 09:27:47.218 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-05-06 09:27:47.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 144: callback 124
2020-05-06 09:27:47.222 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=124, payload=7C 00 00 02
2020-05-06 09:27:47.223 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 124, Status = Transmission complete and ACK received(0)
2020-05-06 09:27:47.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 144: Advanced to WAIT_DATA
2020-05-06 09:27:47.226 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 144: Transaction not completed
2020-05-06 09:27:47.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=10, callback=0, payload=00 0A 04 86 14 73 01
2020-05-06 09:27:47.230 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2020-05-06 09:27:47.231 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Application Command Request (ALIVE:VERSION)
2020-05-06 09:27:47.233 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Incoming command class COMMAND_CLASS_VERSION, endpoint 0
2020-05-06 09:27:47.234 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: SECURITY not supported
2020-05-06 09:27:47.236 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 10: Received COMMAND_CLASS_VERSION V0 VERSION_COMMAND_CLASS_REPORT
2020-05-06 09:27:47.237 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 10: Process Version Command Class Report
2020-05-06 09:27:47.239 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 10: Requested Command Class = COMMAND_CLASS_POWERLEVEL, Version = 1
2020-05-06 09:27:47.241 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 10: Version = 1, version set. Enabling extra functionality.
2020-05-06 09:27:47.242 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Commands processed 1.
2020-05-06 09:27:47.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@15be65f.
2020-05-06 09:27:47.245 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@15be65f.
2020-05-06 09:27:47.247 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: notifyTransactionResponse TID:144 DONE
2020-05-06 09:27:47.249 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-05-06 09:27:47.249 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 144: Transaction event listener: DONE: DONE ->
2020-05-06 09:27:47.250 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@23472f
2020-05-06 09:27:47.250 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2020-05-06 09:27:47.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2020-05-06 09:27:47.252 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init transaction completed with response COMPLETE
2020-05-06 09:27:47.254 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node advancer: VERSION - checking COMMAND_CLASS_ASSOCIATION_GRP_INFO, version is 0
2020-05-06 09:27:47.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-05-06 09:27:47.255 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node advancer: VERSION - queued COMMAND_CLASS_ASSOCIATION_GRP_INFO
2020-05-06 09:27:47.257 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 10: Creating new message for application command VERSION_COMMAND_CLASS_GET command class COMMAND_CLASS_ASSOCIATION_GRP_INFO
2020-05-06 09:27:47.258 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0A 02 84 08 25 7D 39
2020-05-06 09:27:47.259 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: ZWaveCommandClassTransactionPayload - send to node
2020-05-06 09:27:47.261 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: SECURITY not supported
2020-05-06 09:27:47.261 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 10: Sending REQUEST Message = 01 09 00 13 0A 02 84 08 25 7D 39
2020-05-06 09:27:47.263 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-05-06 09:27:47.263 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Command Class COMMAND_CLASS_VERSION is NOT required to be secured
2020-05-06 09:27:47.294 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-05-06 09:27:47.264 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@2384e7
2020-05-06 09:27:47.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Bump transaction 146 priority from Config to Immediate
2020-05-06 09:27:47.264 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Adding to device queue
2020-05-06 09:27:47.301 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Added 146 to queue - size 3
2020-05-06 09:27:47.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:47.304 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:47.305 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:47.305 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2020-05-06 09:27:47.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-05-06 09:27:47.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:47.312 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7D 00 00 02 94
2020-05-06 09:27:47.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.316 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=125, payload=7D 00 00 02
2020-05-06 09:27:47.317 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:47.318 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.320 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:47.322 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: sentData successfully placed on stack.
2020-05-06 09:27:47.324 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 145: Advanced to WAIT_REQUEST
2020-05-06 09:27:47.325 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 145: Transaction not completed
2020-05-06 09:27:47.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=125, payload=7D 00 00 02
2020-05-06 09:27:47.329 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.331 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:47.333 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 145: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 125
2020-05-06 09:27:47.335 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 145: (Callback 125)
2020-05-06 09:27:47.337 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-05-06 09:27:47.338 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 145: callback 125
2020-05-06 09:27:47.340 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=125, payload=7D 00 00 02
2020-05-06 09:27:47.342 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 125, Status = Transmission complete and ACK received(0)
2020-05-06 09:27:47.344 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 145: Transaction COMPLETED
2020-05-06 09:27:47.346 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Response processed after 82ms
2020-05-06 09:27:47.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 145: Transaction completed
2020-05-06 09:27:47.349 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: notifyTransactionResponse TID:145 DONE
2020-05-06 09:27:47.350 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-05-06 09:27:47.350 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 145: Transaction event listener: DONE: DONE ->
2020-05-06 09:27:47.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:47.353 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Went to sleep COMPLETE
2020-05-06 09:27:47.354 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-05-06 09:27:47.407 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Is awake with 1 messages in the queue
2020-05-06 09:27:47.409 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Start sleep timer at 5000ms
2020-05-06 09:27:47.411 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveNodeStatusEvent
==> /var/log/openhab2/events.log <==
2020-05-06 09:27:47.428 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:19f9c0a5:node10' has been updated.
==> /var/log/openhab2/openhab.log <==
2020-05-06 09:27:47.430 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 10: Node Status event - Node is AWAKE
2020-05-06 09:27:49.911 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: WakeupTimerTask 1 Messages waiting, state VERSION
2020-05-06 09:27:52.412 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: WakeupTimerTask 1 Messages waiting, state VERSION
2020-05-06 09:27:52.415 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: No more messages, go back to sleep
2020-05-06 09:27:52.417 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 10: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2020-05-06 09:27:52.420 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: SECURITY not supported
2020-05-06 09:27:52.422 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 10: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2020-05-06 09:27:52.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@11abfda
2020-05-06 09:27:52.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Bump transaction 147 priority from Immediate to Immediate
2020-05-06 09:27:52.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Adding to device queue
2020-05-06 09:27:52.434 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Added 147 to queue - size 4
2020-05-06 09:27:52.436 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-05-06 09:27:52.441 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0A 03 86 13 59 25 7E 78
2020-05-06 09:27:52.444 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 10: Sending REQUEST Message = 01 0A 00 13 0A 03 86 13 59 25 7E 78
2020-05-06 09:27:52.447 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-05-06 09:27:52.450 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 146: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:52.451 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-05-06 09:27:52.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:52.460 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-05-06 09:27:52.463 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 146: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:52.463 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2020-05-06 09:27:52.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-05-06 09:27:52.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:52.469 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:52.472 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:52.476 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:52.479 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 146: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:52.483 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:52.486 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 146: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:52.490 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2020-05-06 09:27:52.493 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: sentData successfully placed on stack.
2020-05-06 09:27:52.496 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 146: Advanced to WAIT_REQUEST
2020-05-06 09:27:52.500 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 146: Transaction not completed
2020-05-06 09:27:52.503 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:52.505 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-05-06 09:27:56.663 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7E 01 01 A5 30
2020-05-06 09:27:56.669 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=126, payload=7E 01 01 A5
2020-05-06 09:27:56.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=126, payload=7E 01 01 A5
2020-05-06 09:27:56.677 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 146: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:56.680 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-05-06 09:27:56.683 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 146: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 126
2020-05-06 09:27:56.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 146: (Callback 126)
2020-05-06 09:27:56.690 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-05-06 09:27:56.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 146: callback 126
2020-05-06 09:27:56.697 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=126, payload=7E 01 01 A5
2020-05-06 09:27:56.701 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 10: SendData Request. CallBack ID = 126, Status = Transmission complete, no ACK received(1)
2020-05-06 09:27:56.704 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 146: Transaction CANCELLED
2020-05-06 09:27:56.708 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-05-06 09:27:56.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Transaction failed waiting for REQUEST, assume sleeping device.
2020-05-06 09:27:56.714 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: CANCEL while sending message. Requeueing - 2 attempts left!
2020-05-06 09:27:56.718 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 146: Transaction RESET with 2 retries remaining.
2020-05-06 09:27:56.721 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Adding to device queue
2020-05-06 09:27:56.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: Added 146 to queue - size 4
2020-05-06 09:27:56.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-05-06 09:27:56.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: TID 146: Transaction not completed
2020-05-06 09:27:56.735 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-05-06 09:27:56.739 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.Alright you cool cats and kittens (feel free to flag me for using that Tiger King reference, i understand), i was able to get this to work! Here is what I did and what i learned.
Thank you all for your help!
No, some combinations of the described method always worked, although it took some (a lot 
) patience sometimes.
If you see it was recognized in PaperUI, then all is good. The name is then something like “Motion Sensor NAS-DS01Z blah blah”, and you have then access to the Thing’s Settings…
The game to update the Thing’s Settings is then the same… Sometimes instantly, sometimes some persuasion is required.
At which point the XML is written, I have never cared about. If you logout out of OH, it should be written at the latest, I think. @chris could say more about how the binding it handles, but I think it’s of no practical use to know it.
Haha, I just realized that we talk about a door sensor. I was thinking it’s about the motion sensor, which is NAS-PD01Z.
I run and catch our lost Harald back to this thread… 
Obviously the methods work on both devices. Probably on all Coolcam stuff, as the core electronic is probably the same…
Which is absolutely correct. The XML is really managed by the binding and shouldn’t be something that anyone should worry about.
Not necessarily. The XML is written when there is information to write. If the binding hasn’t received information about the device, then it won’t write the file. The XML gets written at a couple of points during discovery - once initialisation is complete and it has all the information it needs from the device, then yes, it will normally always be written when the binding closes.
I hope that helps.
Hi, really fast 3x click Wake Up the device, great!
If this is not already written in the database, it would be great if someone could do an update for any devices for which this is relevant so that it goes through into the documentation and we don’t lose this information in the “fog of the forum” 
I have update the „NAS-PD01Z“ Device in the Database!
This topic was automatically closed 41 days after the last reply. New replies are no longer allowed.