[SOLVED] Z-Wave Door Sensor Shenzen Neo: No XML-File generated

Add-ons Bindings
, ,
1

Hi everybody,

i am running Openhab on a Raspi3 for several month. I use bindings for Homegear, Yeelight, Fritz, Z-Wave… But now i have a little problem with a door sensor from Shenzen Neo GC00AM NAS DS01Z.
System: Raspberry Pi 3
OS: Raspbian Jessi, dist-upgrade every week
Openhab 2.1.0 release build
Z-Wave-Stick: Aeotec AEOEZW090-C Gen 5
Z-Wave-Devices: 2x PAN11 Smart EnergyPlugSwitch, 1x Shenzen Neo Power Plug => it works

I have tried a 6-month old installation of Openhab2, then switched to snapshot 3 weeks ago, went back to stable release 2.1.0 with a fresh installation of the Raspi. But every time the door sensor was included there was no XML-File generated. It can be easy included and excluded.
Yesterday i made a fresh inclusion with DEBUG-Level in the logs:

2017-10-10 19:08:51.915 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 01 02 00 00 B1 
2017-10-10 19:08:51.918 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:08:51.919 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 07 00 4A 01 02 00 00 B1 
2017-10-10 19:08:51.920 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 07 00 4A 01 02 00 00 B1 
2017-10-10 19:08:51.920 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 02 00 00 
2017-10-10 19:08:51.921 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: New node found.
2017-10-10 19:08:51.922 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=C1 01 
2017-10-10 19:08:51.923 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 02 00 00 
2017-10-10 19:08:51.924 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=AddNodeToNetwork, callback id=0, expected=AddNodeToNetwork, cancelled=false        transaction complete!
2017-10-10 19:08:51.924 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-10-10 19:08:52.109 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 16 00 4A 01 03 06 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 C0 
2017-10-10 19:08:52.112 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:08:52.113 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 16 00 4A 01 03 06 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 C0 
2017-10-10 19:08:52.114 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 16 00 4A 01 03 06 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 C0 
2017-10-10 19:08:52.116 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 03 06 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 
2017-10-10 19:08:52.117 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - NODE 6: Adding slave.
2017-10-10 19:08:52.118 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInclusionEvent
2017-10-10 19:08:52.119 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.
2017-10-10 19:08:52.119 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-10-10 19:08:52.120 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-10-10 19:08:52.120 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave controller end inclusion
2017-10-10 19:08:52.120 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Including node.
2017-10-10 19:08:52.120 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 01 B4 
2017-10-10 19:08:52.121 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 01 B4 
2017-10-10 19:08:52.123 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class ZWAVE_PLUS_INFO
2017-10-10 19:08:52.124 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class ZWAVE_PLUS_INFO, endpoint null created
2017-10-10 19:08:52.125 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class ZWAVE_PLUS_INFO.
2017-10-10 19:08:52.125 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class ZWAVE_PLUS_INFO to the list of supported command classes.
2017-10-10 19:08:52.126 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class VERSION
2017-10-10 19:08:52.126 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class VERSION, endpoint null created
2017-10-10 19:08:52.127 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class VERSION.
2017-10-10 19:08:52.127 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class VERSION to the list of supported command classes.
2017-10-10 19:08:52.127 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class MANUFACTURER_SPECIFIC
2017-10-10 19:08:52.128 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class MANUFACTURER_SPECIFIC, endpoint null created
2017-10-10 19:08:52.128 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class MANUFACTURER_SPECIFIC.
2017-10-10 19:08:52.128 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class MANUFACTURER_SPECIFIC to the list of supported command classes.
2017-10-10 19:08:52.129 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class DEVICE_RESET_LOCALLY
2017-10-10 19:08:52.129 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class DEVICE_RESET_LOCALLY, endpoint null created
2017-10-10 19:08:52.129 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class DEVICE_RESET_LOCALLY.
2017-10-10 19:08:52.130 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class DEVICE_RESET_LOCALLY to the list of supported command classes.
2017-10-10 19:08:52.130 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class POWERLEVEL
2017-10-10 19:08:52.130 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class POWERLEVEL, endpoint null created
2017-10-10 19:08:52.131 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class POWERLEVEL.
2017-10-10 19:08:52.131 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class POWERLEVEL to the list of supported command classes.
2017-10-10 19:08:52.132 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class BATTERY
2017-10-10 19:08:52.133 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class BATTERY, endpoint null created
2017-10-10 19:08:52.133 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class BATTERY.
2017-10-10 19:08:52.133 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class BATTERY to the list of supported command classes.
2017-10-10 19:08:52.134 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class ALARM
2017-10-10 19:08:52.134 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class ALARM, endpoint null created
2017-10-10 19:08:52.135 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class ALARM.
2017-10-10 19:08:52.135 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class ALARM to the list of supported command classes.
2017-10-10 19:08:52.135 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class SENSOR_BINARY
2017-10-10 19:08:52.136 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class SENSOR_BINARY, endpoint null created
2017-10-10 19:08:52.136 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class SENSOR_BINARY.
2017-10-10 19:08:52.137 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class SENSOR_BINARY to the list of supported command classes.
2017-10-10 19:08:52.137 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class ASSOCIATION
2017-10-10 19:08:52.138 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class ASSOCIATION, endpoint null created
2017-10-10 19:08:52.138 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class ASSOCIATION.
2017-10-10 19:08:52.139 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class ASSOCIATION to the list of supported command classes.
2017-10-10 19:08:52.139 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class ASSOCIATION_GROUP_INFO
2017-10-10 19:08:52.140 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class ASSOCIATION_GROUP_INFO, endpoint null created
2017-10-10 19:08:52.141 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class ASSOCIATION_GROUP_INFO.
2017-10-10 19:08:52.141 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class ASSOCIATION_GROUP_INFO to the list of supported command classes.
2017-10-10 19:08:52.142 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class WAKE_UP
2017-10-10 19:08:52.143 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class WAKE_UP, endpoint null created
2017-10-10 19:08:52.144 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class WAKE_UP.
2017-10-10 19:08:52.145 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class WAKE_UP to the list of supported command classes.
2017-10-10 19:08:52.145 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class CONFIGURATION
2017-10-10 19:08:52.146 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class CONFIGURATION, endpoint null created
2017-10-10 19:08:52.146 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 6: Inclusion is adding command class CONFIGURATION.
2017-10-10 19:08:52.146 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class CONFIGURATION to the list of supported command classes.
2017-10-10 19:08:52.147 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=C1 01 
2017-10-10 19:08:52.148 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 03 06 0F 04 07 01 5E 86 72 5A 73 80 71 30 85 59 84 70 
2017-10-10 19:08:52.149 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=AddNodeToNetwork, callback id=0, expected=AddNodeToNetwork, cancelled=false        transaction complete!
2017-10-10 19:08:52.149 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-10-10 19:08:52.150 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 28ms/4178ms.
2017-10-10 19:08:52.175 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 01 06 06 00 B3 
2017-10-10 19:08:52.176 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:08:52.178 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 07 00 4A 01 06 06 00 B3 
2017-10-10 19:08:52.180 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 07 00 4A 01 06 06 00 B3 
2017-10-10 19:08:52.182 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 06 06 00 
2017-10-10 19:08:52.184 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Done.
2017-10-10 19:08:52.184 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInclusionEvent
2017-10-10 19:08:52.185 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 6: Device discovered
2017-10-10 19:08:52.201 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:ZWAVE:node6' to inbox.
2017-10-10 19:08:52.203 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Starting initialisation from INCLUSION_START
2017-10-10 19:08:52.204 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - INCLUSION_START: queue length(0), free to send(true)
2017-10-10 19:08:52.204 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: loop - INCLUSION_START try 1: stageAdvanced(false)
2017-10-10 19:08:52.204 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: Unknown node state INCLUSION_START encountered.
2017-10-10 19:08:52.205 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - advancing to IDENTIFY_NODE
2017-10-10 19:08:52.205 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent
2017-10-10 19:08:52.205 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: loop - IDENTIFY_NODE try 0: stageAdvanced(true)
2017-10-10 19:08:52.206 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: PROTOINFO - send IdentifyNode
2017-10-10 19:08:52.206 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - queued packet. Queue length is 1
2017-10-10 19:08:52.207 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-10-10 19:08:52.207 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=05 01 
2017-10-10 19:08:52.208 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=AddNodeToNetwork[0x4A], type=Request[0x00], priority=High, dest=255, callback=0, payload=01 06 06 00 
2017-10-10 19:08:52.209 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=AddNodeToNetwork, callback id=0, expected=AddNodeToNetwork, cancelled=false        transaction complete!
2017-10-10 19:08:52.209 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-10-10 19:08:52.209 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-10-10 19:08:52.209 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 41 06 BC 
2017-10-10 19:08:52.210 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 41 06 BC 
2017-10-10 19:08:52.214 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 01 41 53 9C 01 04 07 01 7A 
2017-10-10 19:08:52.216 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:08:52.217 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 01 41 53 9C 01 04 07 01 7A 
2017-10-10 19:08:52.217 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 01 41 53 9C 01 04 07 01 7A 
2017-10-10 19:08:52.218 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=IdentifyNode[0x41], type=Response[0x01], priority=High, dest=255, callback=0, payload=53 9C 01 04 07 01 
2017-10-10 19:08:52.219 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: ProtocolInfo
2017-10-10 19:08:52.219 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Listening = false
2017-10-10 19:08:52.219 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Routing = true
2017-10-10 19:08:52.219 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Beaming = true
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Version = 4
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: FLIRS = false
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Security = false
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Max Baud = 40000
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Basic = Routing Slave
2017-10-10 19:08:52.220 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Generic = Sensor Notification
2017-10-10 19:08:52.221 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 6: Specific = Notification Sensor
2017-10-10 19:08:52.221 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class NO_OPERATION
2017-10-10 19:08:52.222 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class NO_OPERATION, endpoint null created
2017-10-10 19:08:52.223 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Version = 1, version set. Enabling extra functionality.
2017-10-10 19:08:52.223 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class NO_OPERATION to the list of supported command classes.
2017-10-10 19:08:52.223 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Creating new instance of command class BASIC
2017-10-10 19:08:52.224 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Command class BASIC, endpoint null created
2017-10-10 19:08:52.224 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Adding command class BASIC to the list of supported command classes.
2017-10-10 19:08:52.224 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=IdentifyNode[0x41], type=Request[0x00], priority=High, dest=255, callback=0, payload=06 
2017-10-10 19:08:52.225 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=IdentifyNode[0x41], type=Response[0x01], priority=High, dest=255, callback=0, payload=53 9C 01 04 07 01 
2017-10-10 19:08:52.225 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=IdentifyNode, callback id=0, expected=IdentifyNode, cancelled=false        transaction complete!
2017-10-10 19:08:52.225 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-10-10 19:08:52.226 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - IDENTIFY_NODE: Transaction complete (IdentifyNode:Request) success(true)
2017-10-10 19:08:52.226 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - checking initialisation queue. Queue size 1.
2017-10-10 19:08:52.228 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - message removed from queue. Queue size 0.
2017-10-10 19:08:52.229 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - IDENTIFY_NODE: queue length(0), free to send(true)
2017-10-10 19:08:52.229 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: loop - IDENTIFY_NODE try 1: stageAdvanced(false)
2017-10-10 19:08:52.229 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - advancing to MANUFACTURER
2017-10-10 19:08:52.229 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent
2017-10-10 19:08:52.230 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: loop - MANUFACTURER try 0: stageAdvanced(true)
2017-10-10 19:08:52.230 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer: MANUFACTURER - send ManufacturerSpecific
2017-10-10 19:08:52.230 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 6: Creating new message for command MANUFACTURER_SPECIFIC_GET
2017-10-10 19:08:52.231 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 6: Node advancer - queued packet. Queue length is 1
2017-10-10 19:08:52.232 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 6: Putting message SendData in wakeup queue.
2017-10-10 19:08:52.232 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 22ms/4178ms.
2017-10-10 19:09:08.079 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Stage PING. Initialisation retry timer triggered. Increased to 80000
2017-10-10 19:09:08.080 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node advancer - PING: queue length(0), free to send(false)
2017-10-10 19:09:08.081 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Initialisation retry timer started 80000
2017-10-10 19:09:08.081 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node advancer: loop - PING try 4: stageAdvanced(false)
2017-10-10 19:09:08.082 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node advancer: PING - send NoOperation
2017-10-10 19:09:08.082 [DEBUG] [ndclass.ZWaveNoOperationCommandClass] - NODE 5: Creating new message for command No Operation
2017-10-10 19:09:08.082 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node advancer - queued packet. Queue length is 1
2017-10-10 19:09:08.083 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-10-10 19:09:08.084 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 05 01 00 25 27 E2 
2017-10-10 19:09:08.085 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 5: Sending REQUEST Message = 01 08 00 13 05 01 00 25 27 E2 
2017-10-10 19:09:08.087 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 0. Queue={}
2017-10-10 19:09:08.099 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2017-10-10 19:09:08.101 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:09:08.102 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 
2017-10-10 19:09:08.102 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 
2017-10-10 19:09:08.103 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 
2017-10-10 19:09:08.104 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: Sent Data successfully placed on stack.
2017-10-10 19:09:12.167 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 27 01 01 97 5B 
2017-10-10 19:09:12.169 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-10-10 19:09:12.170 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 27 01 01 97 00 00 55 
2017-10-10 19:09:12.171 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 27 01 01 97 00 00 55 
2017-10-10 19:09:12.172 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=27 01 01 97 
2017-10-10 19:09:12.172 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: SendData Request. CallBack ID = 39, Status = Transmission complete, no ACK received(1)
2017-10-10 19:09:12.173 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 5: Node is DEAD. Dropping message.
2017-10-10 19:09:12.173 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-10-10 19:09:12.173 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Node advancer - PING: Transaction complete (SendData:Request) success(false)
2017-10-10 19:09:12.173 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-10-10 19:09:12.174 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 5: Response processed after 4088ms/4178ms.
2017-10-10 19:09:14.031 [DEBUG] [ve.internal.protocol.ZWaveController] - Stopping inclusion timer.
2017-10-10 19:09:14.032 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.
2017-10-10 19:09:14.032 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-10-10 19:09:14.033 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-10-10 19:09:14.033 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWave controller end inclusion
2017-10-10 19:09:14.033 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 01 B4

As the sensor is a battery device i have pushed the button for updating a lot of times. Brought the Raspbi very near(5 cm) close to the sensor, get away 1m, but no XML was generated.

Did anyone got this sensor working?
Any other hints other than throwing in the trash and buy a fibaro ;.)
Many thanks for your hints and helping

Greets
Andy

2

I do have it and works fine… they way it works for me is…
First add a thing… it should be in the inbox… add it to your things… then wait a few seconds… and press again three times the button on the sensor… wait a little bit and should be recognized… if not try again and press one more time the button for 3 times… give it some time… if not… reboot OpenHab…

3

Hy,
good to know that you brought the sensor to live, but 3 times button pressing should start the in/exclusion-Mode. Anyway, i will try today evening. thanks. Any hints are welcome

4

There is no wakeup showing in the log above. Maybe this log doesn’t contain everything, but based on this I would say it’s not waking up.

5

I have checked the entire log with the ZWave Log Viewer and there is no sign of waking up for Node 6

2017-10-11 14_59_21-ZWave Log Viewer
2017-10-11 14_59_21-ZWave Log Viewer.png1023×583 83.9 KB

today evening i will push the button hard to get a wake up sign…

6

Finally it works! Pushing the button in many different combinations brought a wakeup, XML-File and finally ONLINE in Openhab2. Many thanks!

1 Like
7

I think I have the same devices

https://www.szneo.com/en/products/show.php?id=188

https://www.cd-jackson.com/index.php/zwave/zwave-device-database/zwave-device-list/devicesummary/400

I do get binary reports in the zwave debug log when I open/close sensor but no XML file is generated. I tried the button press 3 times but still no joy.

I picked up a few of these really inexpensive. Zstick links to them and you have (I think) a db entry but no xml file generated. Also it doesn’t report the manufacture

8

Probably you need to wake up the device so that it can complete the initialisation. If it doesn’t wake up, then the binding can’t communicate with the device.

9

Chris it seems to be awake because open and close events show in the log.

If device sends events why can we manually register it?

10

There’s a difference between the device being awake and it sending open/close events. Battery-powered devices generally are not “awake” when they send these events. A device is only awake when it wakes up on a set wake up interval (although some devices to not wake up by default), or when it is manually woken up. Manually waking up a device is typically performed by some sequence of button presses as defined in the device manual. Some devices need to be woken up multiple times in order for them to complete initialization.

11

Hi thanks for your reply

I did the button press option multiple times…

Strange thing is if the device sends events…why ignore them? Seems system would be more user friendly this process could be simplified to just allow the events and let the system operate.

12

They aren’t ignored, but they aren’t usable for communication with the device. ZWave battery devices sleep most of the time. When they are ready for the controller to send data TO them, they send a WAKEUP notification. If they are just notifying that the temperature has changed, or the door has opened, the notification is different and it’s not possible to send data TO the device.