POPP Z-Wave Wall Plug Switch - Interview won't finish

Discussions about existing Z-Wave device and their usage with Z-Way/Z-Cloud/Z-Box
Post Reply
debil
Posts: 2
Joined: 18 Nov 2017 02:56

POPP Z-Wave Wall Plug Switch - Interview won't finish

Post by debil » 18 Nov 2017 03:04

I'm trying to add this device, however it never finishes.

Log of the whole Interview process:

Code: Select all

[2017-11-18 02:59:37.450] [D] [zway] SETDATA controller.data.secureInclusion = False
[2017-11-18 02:59:47.442] [I] [zway] Adding job: Add/re-include node to network
[2017-11-18 02:59:47.445] [D] [zway] SENDING (cb 0x66): ( 01 05 00 4A C1 66 17 )
[2017-11-18 02:59:47.447] [D] [zway] RECEIVED ACK
[2017-11-18 02:59:47.456] [D] [zway] RECEIVED: ( 01 07 00 4A 66 01 00 00 D5 )
[2017-11-18 02:59:47.457] [D] [zway] SENT ACK
[2017-11-18 02:59:47.457] [D] [zway] SETDATA controller.data.lastIncludedDevice = Empty
[2017-11-18 02:59:47.458] [D] [zway] SETDATA controller.data.lastExcludedDevice = Empty
[2017-11-18 02:59:47.458] [I] [zway] Job 0x4a (Add/re-include node to network): Ready to add - push button on the device to be added
[2017-11-18 02:59:47.459] [D] [zway] SETDATA controller.data.controllerState = 1 (0x00000001)
[2017-11-18 02:59:52.164] [D] [zway] RECEIVED: ( 01 14 00 4A 66 02 02 0D 04 10 01 20 25 27 70 75 86 72 85 87 77 79 )
[2017-11-18 02:59:52.166] [D] [zway] SENT ACK
[2017-11-18 02:59:52.166] [I] [zway] Job 0x4a (Add/re-include node to network): Node found: #2
[2017-11-18 02:59:52.167] [D] [zway] SETDATA controller.data.controllerState = 2 (0x00000002)
[2017-11-18 02:59:52.167] [D] [zway] SETDATA devices.2.data = Empty
[2017-11-18 02:59:52.168] [D] [zway] SETDATA devices.2.instances.0.data = Empty
[2017-11-18 02:59:52.168] [D] [zway] SETDATA devices.2.instances.0.data.dynamic = Empty
[2017-11-18 02:59:52.169] [D] [zway] SETDATA devices.2.instances.0.data.dynamic = False
[2017-11-18 02:59:52.169] [D] [zway] SETDATA devices.2.instances.0.data.genericType = Empty
[2017-11-18 02:59:52.170] [D] [zway] SETDATA devices.2.instances.0.data.genericType = 0 (0x00000000)
[2017-11-18 02:59:52.171] [D] [zway] SETDATA devices.2.instances.0.data.specificType = Empty
[2017-11-18 02:59:52.171] [D] [zway] SETDATA devices.2.instances.0.data.specificType = 0 (0x00000000)
[2017-11-18 02:59:52.172] [D] [zway] SETDATA devices.2.instances.0.data.nodeInfoFrame = Empty
[2017-11-18 02:59:52.172] [D] [zway] SETDATA devices.2.data.basicType = Empty
[2017-11-18 02:59:52.173] [D] [zway] SETDATA devices.2.data.genericType = Empty
[2017-11-18 02:59:52.174] [D] [zway] SETDATA devices.2.data.specificType = Empty
[2017-11-18 02:59:52.174] [D] [zway] SETDATA devices.2.data.infoProtocolSpecific = Empty
[2017-11-18 02:59:52.175] [D] [zway] SETDATA devices.2.data.deviceTypeString = Empty
[2017-11-18 02:59:52.175] [D] [zway] SETDATA devices.2.data.isVirtual = Empty
[2017-11-18 02:59:52.176] [D] [zway] SETDATA devices.2.data.isListening = Empty
[2017-11-18 02:59:52.176] [D] [zway] SETDATA devices.2.data.isRouting = Empty
[2017-11-18 02:59:52.177] [D] [zway] SETDATA devices.2.data.isAwake = Empty
[2017-11-18 02:59:52.177] [D] [zway] SETDATA devices.2.data.optional = Empty
[2017-11-18 02:59:52.178] [D] [zway] SETDATA devices.2.data.isFailed = Empty
[2017-11-18 02:59:52.178] [D] [zway] SETDATA devices.2.data.sensor250 = Empty
[2017-11-18 02:59:52.179] [D] [zway] SETDATA devices.2.data.sensor1000 = Empty
[2017-11-18 02:59:52.179] [D] [zway] SETDATA devices.2.data.neighbours = Empty
[2017-11-18 02:59:52.179] [D] [zway] SETDATA devices.2.data.manufacturerId = Empty
[2017-11-18 02:59:52.180] [D] [zway] SETDATA devices.2.data.vendorString = Empty
[2017-11-18 02:59:52.180] [D] [zway] SETDATA devices.2.data.manufacturerProductType = Empty
[2017-11-18 02:59:52.181] [D] [zway] SETDATA devices.2.data.manufacturerProductId = Empty
[2017-11-18 02:59:52.181] [D] [zway] SETDATA devices.2.data.ZWLib = Empty
[2017-11-18 02:59:52.182] [D] [zway] SETDATA devices.2.data.ZWProtocolMajor = Empty
[2017-11-18 02:59:52.182] [D] [zway] SETDATA devices.2.data.ZWProtocolMinor = Empty
[2017-11-18 02:59:52.183] [D] [zway] SETDATA devices.2.data.SDK = Empty
[2017-11-18 02:59:52.183] [D] [zway] SETDATA devices.2.data.applicationMajor = Empty
[2017-11-18 02:59:52.184] [D] [zway] SETDATA devices.2.data.applicationMinor = Empty
[2017-11-18 02:59:52.184] [D] [zway] SETDATA devices.2.data.nodeInfoFrame = Empty
[2017-11-18 02:59:52.185] [D] [zway] SETDATA devices.2.data.ZDDXMLFile = Empty
[2017-11-18 02:59:52.185] [D] [zway] SETDATA devices.2.data.lastSend = Empty
[2017-11-18 02:59:52.186] [D] [zway] SETDATA devices.2.data.lastSendInternal = Empty
[2017-11-18 02:59:52.186] [D] [zway] SETDATA devices.2.data.lastNonceGet = Empty
[2017-11-18 02:59:52.187] [D] [zway] SETDATA devices.2.data.lastReceived = Empty
[2017-11-18 02:59:52.187] [D] [zway] SETDATA devices.2.data.failureCount = Empty
[2017-11-18 02:59:52.188] [D] [zway] SETDATA devices.2.data.keepAwake = Empty
[2017-11-18 02:59:52.188] [D] [zway] SETDATA devices.2.data.queueLength = Empty
[2017-11-18 02:59:52.189] [D] [zway] SETDATA devices.2.data.givenName = Empty
[2017-11-18 02:59:52.189] [D] [zway] SETDATA devices.2.data.basicType = 0 (0x00000000)
[2017-11-18 02:59:52.190] [D] [zway] SETDATA devices.2.data.genericType = 0 (0x00000000)
[2017-11-18 02:59:52.190] [D] [zway] SETDATA devices.2.data.specificType = 0 (0x00000000)
[2017-11-18 02:59:52.191] [D] [zway] SETDATA devices.2.data.infoProtocolSpecific = 0 (0x00000000)
[2017-11-18 02:59:52.191] [D] [zway] SETDATA devices.2.data.deviceTypeString = ""
[2017-11-18 02:59:52.191] [D] [zway] SETDATA devices.2.data.isVirtual = False
[2017-11-18 02:59:52.192] [D] [zway] SETDATA devices.2.data.isListening = True
[2017-11-18 02:59:52.192] [D] [zway] SETDATA devices.2.data.isRouting = False
[2017-11-18 02:59:52.193] [D] [zway] SETDATA devices.2.data.isAwake = False
[2017-11-18 02:59:52.193] [D] [zway] SETDATA devices.2.data.optional = False
[2017-11-18 02:59:52.194] [D] [zway] SETDATA devices.2.data.isFailed = False
[2017-11-18 02:59:52.194] [D] [zway] SETDATA devices.2.data.sensor250 = False
[2017-11-18 02:59:52.195] [D] [zway] SETDATA devices.2.data.sensor1000 = False
[2017-11-18 02:59:52.195] [D] [zway] SETDATA devices.2.data.neighbours = Empty
[2017-11-18 02:59:52.196] [D] [zway] SETDATA devices.2.data.manufacturerId = 0 (0x00000000)
[2017-11-18 02:59:52.196] [D] [zway] SETDATA devices.2.data.manufacturerProductType = 0 (0x00000000)
[2017-11-18 02:59:52.197] [D] [zway] SETDATA devices.2.data.manufacturerProductId = 0 (0x00000000)
[2017-11-18 02:59:52.197] [D] [zway] SETDATA devices.2.data.applicationMajor = 0 (0x00000000)
[2017-11-18 02:59:52.197] [D] [zway] SETDATA devices.2.data.applicationMinor = 0 (0x00000000)
[2017-11-18 02:59:52.198] [D] [zway] SETDATA devices.2.data.ZWProtocolMajor = 0 (0x00000000)
[2017-11-18 02:59:52.198] [D] [zway] SETDATA devices.2.data.ZWProtocolMinor = 0 (0x00000000)
[2017-11-18 02:59:52.199] [D] [zway] SETDATA devices.2.data.ZWLib = 0 (0x00000000)
[2017-11-18 02:59:52.199] [D] [zway] SETDATA devices.2.data.SDK = ""
[2017-11-18 02:59:52.200] [D] [zway] SETDATA devices.2.data.vendorString = ""
[2017-11-18 02:59:52.200] [D] [zway] SETDATA devices.2.data.nodeInfoFrame = Empty
[2017-11-18 02:59:52.201] [D] [zway] SETDATA devices.2.data.ZDDXMLFile = ""
[2017-11-18 02:59:52.201] [D] [zway] SETDATA devices.2.data.keepAwake = False
[2017-11-18 02:59:52.202] [D] [zway] SETDATA devices.2.data.queueLength = 0 (0x00000000)
[2017-11-18 02:59:52.202] [D] [zway] SETDATA devices.2.data.lastReceived = 0 (0x00000000)
[2017-11-18 02:59:52.202] [D] [zway] SETDATA devices.2.data.lastSend = 0 (0x00000000)
[2017-11-18 02:59:52.203] [D] [zway] SETDATA devices.2.data.lastSendInternal = **********
[2017-11-18 02:59:52.203] [D] [zway] SETDATA devices.2.data.failureCount = 0 (0x00000000)
[2017-11-18 02:59:52.204] [D] [zway] SETDATA devices.2.data.givenName = ""
[2017-11-18 02:59:52.204] [I] [zway] Adding job: Get node protocol information
[2017-11-18 02:59:52.205] [I] [zway] Adding job: Get routing table line
[2017-11-18 02:59:52.205] [I] [zway] Adding job: Check if node is failed
[2017-11-18 02:59:52.206] [I] [zway] Adding job: Get routing table line
[2017-11-18 02:59:52.206] [I] [zway] Adding job: Get routing table line
[2017-11-18 02:59:52.207] [D] [zway] Job 0x80 (Get routing table line): removing duplicate
[2017-11-18 02:59:52.207] [D] [zway] SETDATA devices.2.data.basicType = 4 (0x00000004)
[2017-11-18 02:59:52.208] [D] [zway] SETDATA devices.2.data.genericType = 16 (0x00000010)
[2017-11-18 02:59:52.208] [D] [zway] SETDATA devices.2.instances.0.data.genericType = 16 (0x00000010)
[2017-11-18 02:59:52.209] [D] [zway] SETDATA devices.2.data.specificType = 1 (0x00000001)
[2017-11-18 02:59:52.209] [D] [zway] SETDATA devices.2.instances.0.data.specificType = 1 (0x00000001)
[2017-11-18 02:59:52.212] [D] [zway] SETDATA devices.2.data.deviceTypeString = "Binary Power Switch"
[2017-11-18 02:59:52.213] [D] [zway] SETDATA devices.2.data.nodeInfoFrame = byte[10]
[2017-11-18 02:59:52.213] [D] [zway]   ( 20 25 27 70 75 86 72 85 87 77 )
[2017-11-18 02:59:52.214] [D] [zway] SENDING: ( 01 04 00 62 02 9B )
[2017-11-18 02:59:52.214] [W] [zway] Received SOF, while awaiting ACK
[2017-11-18 02:59:52.215] [D] [zway] RECEIVED: ( 01 14 00 4A 66 03 02 0D 04 10 01 20 25 27 70 75 86 72 85 87 77 78 )
[2017-11-18 02:59:52.216] [D] [zway] SENT ACK
[2017-11-18 02:59:52.307] [I] [zway] Job 0x4a (Add/re-include node to network): Adding slave: #2
[2017-11-18 02:59:52.308] [D] [zway] SETDATA controller.data.controllerState = 3 (0x00000003)
[2017-11-18 02:59:52.308] [D] [zway] SETDATA controller.data.lastIncludedDevice = 2 (0x00000002)
[2017-11-18 02:59:52.309] [D] [zway] SETDATA devices.2.data.basicType = 4 (0x00000004)
[2017-11-18 02:59:52.310] [D] [zway] SETDATA devices.2.data.genericType = 16 (0x00000010)
[2017-11-18 02:59:52.310] [D] [zway] SETDATA devices.2.data.specificType = 1 (0x00000001)
[2017-11-18 02:59:52.313] [D] [zway] SETDATA devices.2.data.deviceTypeString = "Binary Power Switch"
[2017-11-18 02:59:52.315] [D] [zway] SETDATA devices.2.data.nodeInfoFrame = byte[10]
[2017-11-18 02:59:52.315] [D] [zway]   ( 20 25 27 70 75 86 72 85 87 77 )
[2017-11-18 02:59:52.316] [D] [zway] RECEIVED CAN
[2017-11-18 02:59:52.327] [D] [zway] SENDING: ( 01 04 00 62 02 9B )
[2017-11-18 02:59:52.330] [D] [zway] RECEIVED ACK
[2017-11-18 02:59:52.330] [D] [zway] RECEIVED: ( 01 04 01 62 01 99 )
[2017-11-18 02:59:52.331] [D] [zway] SENT ACK
[2017-11-18 02:59:52.332] [D] [zway] SETDATA devices.2.data.isFailed = True
[2017-11-18 02:59:52.332] [I] [zway] Job 0x62 (Check if node is failed): Node 2 is failed
[2017-11-18 02:59:52.333] [D] [zway] Job 0x62 (Check if node is failed): success
[2017-11-18 02:59:52.333] [I] [zway] Removing job: Check if node is failed
[2017-11-18 02:59:53.780] [D] [zway] SETDATA devices.2.data.givenName = "Device_2"
[2017-11-18 02:59:59.946] [D] [zway] RECEIVED: ( 01 07 00 4A 66 05 02 00 D3 )
[2017-11-18 02:59:59.946] [D] [zway] SENT ACK
[2017-11-18 02:59:59.946] [D] [zway] SETDATA controller.data.controllerState = 4 (0x00000004)
[2017-11-18 02:59:59.947] [I] [zway] Job 0x4a (Add/re-include node to network): Protocol done
[2017-11-18 02:59:59.947] [D] [zway] SETDATA controller.data.lastIncludedDevice = 2 (0x00000002)
[2017-11-18 02:59:59.947] [I] [zway] Loading Command Classes for device 2
[2017-11-18 02:59:59.947] [I] [zway] Node 2:0 supports CC Basic
[2017-11-18 02:59:59.948] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data = Empty
[2017-11-18 02:59:59.948] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.supported = Empty
[2017-11-18 02:59:59.948] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.supported = True
[2017-11-18 02:59:59.948] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.version = Empty
[2017-11-18 02:59:59.948] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.949] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.security = Empty
[2017-11-18 02:59:59.949] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.security = False
[2017-11-18 02:59:59.949] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.interviewDone = Empty
[2017-11-18 02:59:59.949] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.interviewCounter = Empty
[2017-11-18 02:59:59.949] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.interviewDone = False
[2017-11-18 02:59:59.950] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.950] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.level = Empty
[2017-11-18 02:59:59.950] [I] [zway] Node 2:0 supports CC SwitchBinary
[2017-11-18 02:59:59.950] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data = Empty
[2017-11-18 02:59:59.951] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.supported = Empty
[2017-11-18 02:59:59.951] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.supported = True
[2017-11-18 02:59:59.951] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.version = Empty
[2017-11-18 02:59:59.951] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.951] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.security = Empty
[2017-11-18 02:59:59.952] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.security = False
[2017-11-18 02:59:59.952] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.interviewDone = Empty
[2017-11-18 02:59:59.952] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.interviewCounter = Empty
[2017-11-18 02:59:59.952] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.interviewDone = False
[2017-11-18 02:59:59.952] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.953] [D] [zway] SETDATA devices.2.instances.0.commandClasses.37.data.level = Empty
[2017-11-18 02:59:59.953] [I] [zway] Node 2:0 supports CC SwitchAll
[2017-11-18 02:59:59.953] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data = Empty
[2017-11-18 02:59:59.953] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.supported = Empty
[2017-11-18 02:59:59.953] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.supported = True
[2017-11-18 02:59:59.954] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.version = Empty
[2017-11-18 02:59:59.954] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.954] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.security = Empty
[2017-11-18 02:59:59.954] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.security = False
[2017-11-18 02:59:59.954] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.interviewDone = Empty
[2017-11-18 02:59:59.955] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.interviewCounter = Empty
[2017-11-18 02:59:59.955] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.interviewDone = False
[2017-11-18 02:59:59.955] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.955] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.mode = Empty
[2017-11-18 02:59:59.956] [D] [zway] SETDATA devices.2.instances.0.commandClasses.39.data.onOff = Empty
[2017-11-18 02:59:59.956] [I] [zway] Node 2:0 supports CC Configuration
[2017-11-18 02:59:59.956] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data = Empty
[2017-11-18 02:59:59.956] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.supported = Empty
[2017-11-18 02:59:59.957] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.supported = True
[2017-11-18 02:59:59.957] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.version = Empty
[2017-11-18 02:59:59.957] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.957] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.security = Empty
[2017-11-18 02:59:59.957] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.security = False
[2017-11-18 02:59:59.958] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.interviewDone = Empty
[2017-11-18 02:59:59.958] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.interviewCounter = Empty
[2017-11-18 02:59:59.958] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.interviewDone = False
[2017-11-18 02:59:59.958] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.959] [I] [zway] Node 2:0 supports CC ManufacturerSpecific
[2017-11-18 02:59:59.959] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data = Empty
[2017-11-18 02:59:59.959] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.supported = Empty
[2017-11-18 02:59:59.959] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.supported = True
[2017-11-18 02:59:59.960] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.version = Empty
[2017-11-18 02:59:59.960] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.960] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.security = Empty
[2017-11-18 02:59:59.960] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.security = False
[2017-11-18 02:59:59.961] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.interviewDone = Empty
[2017-11-18 02:59:59.961] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.interviewCounter = Empty
[2017-11-18 02:59:59.961] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.interviewDone = False
[2017-11-18 02:59:59.961] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.961] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.vendorId = Empty
[2017-11-18 02:59:59.962] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.vendor = Empty
[2017-11-18 02:59:59.962] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.productId = Empty
[2017-11-18 02:59:59.962] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.productType = Empty
[2017-11-18 02:59:59.962] [D] [zway] SETDATA devices.2.instances.0.commandClasses.114.data.serialNumber = Empty
[2017-11-18 02:59:59.963] [I] [zway] Node 2:0 supports CC Protection
[2017-11-18 02:59:59.963] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data = Empty
[2017-11-18 02:59:59.963] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.supported = Empty
[2017-11-18 02:59:59.963] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.supported = True
[2017-11-18 02:59:59.963] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.version = Empty
[2017-11-18 02:59:59.964] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.964] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.security = Empty
[2017-11-18 02:59:59.964] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.security = False
[2017-11-18 02:59:59.964] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.interviewDone = Empty
[2017-11-18 02:59:59.965] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.interviewCounter = Empty
[2017-11-18 02:59:59.965] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.interviewDone = False
[2017-11-18 02:59:59.965] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.965] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.state = Empty
[2017-11-18 02:59:59.966] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.rfState = Empty
[2017-11-18 02:59:59.966] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.exclusive = Empty
[2017-11-18 02:59:59.966] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.timeout = Empty
[2017-11-18 02:59:59.966] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.stateCap = Empty
[2017-11-18 02:59:59.966] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.rfStateCap = Empty
[2017-11-18 02:59:59.967] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.exclusiveCap = Empty
[2017-11-18 02:59:59.967] [D] [zway] SETDATA devices.2.instances.0.commandClasses.117.data.timeoutCap = Empty
[2017-11-18 02:59:59.967] [I] [zway] Node 2:0 supports CC NodeNaming
[2017-11-18 02:59:59.968] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data = Empty
[2017-11-18 02:59:59.968] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.supported = Empty
[2017-11-18 02:59:59.968] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.supported = True
[2017-11-18 02:59:59.968] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.version = Empty
[2017-11-18 02:59:59.968] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.969] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.security = Empty
[2017-11-18 02:59:59.969] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.security = False
[2017-11-18 02:59:59.969] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.interviewDone = Empty
[2017-11-18 02:59:59.969] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.interviewCounter = Empty
[2017-11-18 02:59:59.970] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.interviewDone = False
[2017-11-18 02:59:59.970] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.970] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.nodename = Empty
[2017-11-18 02:59:59.970] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.location = Empty
[2017-11-18 02:59:59.970] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.nameEncoding = Empty
[2017-11-18 02:59:59.971] [D] [zway] SETDATA devices.2.instances.0.commandClasses.119.data.locationEncoding = Empty
[2017-11-18 02:59:59.971] [I] [zway] Node 2:0 supports CC Association
[2017-11-18 02:59:59.971] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data = Empty
[2017-11-18 02:59:59.971] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.supported = Empty
[2017-11-18 02:59:59.972] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.supported = True
[2017-11-18 02:59:59.972] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.version = Empty
[2017-11-18 02:59:59.972] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.972] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.security = Empty
[2017-11-18 02:59:59.973] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.security = False
[2017-11-18 02:59:59.973] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.interviewDone = Empty
[2017-11-18 02:59:59.973] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.interviewCounter = Empty
[2017-11-18 02:59:59.973] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.interviewDone = False
[2017-11-18 02:59:59.973] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.974] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.groups = Empty
[2017-11-18 02:59:59.974] [D] [zway] SETDATA devices.2.instances.0.commandClasses.133.data.specificGroup = Empty
[2017-11-18 02:59:59.974] [I] [zway] Node 2:0 supports CC Version
[2017-11-18 02:59:59.975] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data = Empty
[2017-11-18 02:59:59.975] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.supported = Empty
[2017-11-18 02:59:59.975] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.supported = True
[2017-11-18 02:59:59.975] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.version = Empty
[2017-11-18 02:59:59.975] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.976] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.security = Empty
[2017-11-18 02:59:59.976] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.security = False
[2017-11-18 02:59:59.976] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewDone = Empty
[2017-11-18 02:59:59.976] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewCounter = Empty
[2017-11-18 02:59:59.977] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewDone = False
[2017-11-18 02:59:59.977] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.977] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.ZWLib = Empty
[2017-11-18 02:59:59.977] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.ZWProtocolMajor = Empty
[2017-11-18 02:59:59.977] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.ZWProtocolMinor = Empty
[2017-11-18 02:59:59.978] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.SDK = Empty
[2017-11-18 02:59:59.978] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.applicationMajor = Empty
[2017-11-18 02:59:59.978] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.applicationMinor = Empty
[2017-11-18 02:59:59.978] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.hardwareVersion = Empty
[2017-11-18 02:59:59.978] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.firmwareCount = Empty
[2017-11-18 02:59:59.979] [I] [zway] Node 2:0 supports CC Indicator
[2017-11-18 02:59:59.979] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data = Empty
[2017-11-18 02:59:59.979] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.supported = Empty
[2017-11-18 02:59:59.979] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.supported = True
[2017-11-18 02:59:59.979] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.version = Empty
[2017-11-18 02:59:59.980] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.version = 1 (0x00000001)
[2017-11-18 02:59:59.980] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.security = Empty
[2017-11-18 02:59:59.980] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.security = False
[2017-11-18 02:59:59.980] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.interviewDone = Empty
[2017-11-18 02:59:59.980] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.interviewCounter = Empty
[2017-11-18 02:59:59.981] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.interviewDone = False
[2017-11-18 02:59:59.981] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.interviewCounter = 10 (0x0000000a)
[2017-11-18 02:59:59.981] [D] [zway] SETDATA devices.2.instances.0.commandClasses.135.data.stat = Empty
[2017-11-18 02:59:59.981] [I] [zway] Loading remaining controlled Command Classes for device 2
[2017-11-18 02:59:59.981] [I] [zway] Node 2 controls CC Basic
[2017-11-18 02:59:59.982] [D] [zway] SETDATA devices.2.data.lastSendInternal = **********
[2017-11-18 02:59:59.982] [D] [zway] SETDATA devices.2.data.isAwake = True
[2017-11-18 02:59:59.983] [D] [zway] SETDATA devices.2.data.lastSendInternal = **********
[2017-11-18 02:59:59.983] [D] [zway] SETDATA devices.2.data.lastNonceGet = 621056 (0x00097a00)
[2017-11-18 02:59:59.983] [I] [zway] Interview step 1 skipped due to absence of Security CC
[2017-11-18 02:59:59.984] [I] [zway] Interview step 2
[2017-11-18 02:59:59.984] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewDone = False
[2017-11-18 02:59:59.984] [D] [zway] SETDATA devices.2.instances.0.commandClasses.134.data.interviewCounter = 9 (0x00000009)
[2017-11-18 02:59:59.985] [I] [zway] Node 2:0 CC Version Interview started
[2017-11-18 02:59:59.985] [I] [zway] Adding job: Basic Version Get
[2017-11-18 02:59:59.985] [I] [zway] Adding job: SwitchBinary Version Get
[2017-11-18 02:59:59.985] [I] [zway] Adding job: SwitchAll Version Get
[2017-11-18 02:59:59.986] [I] [zway] Adding job: Configuration Version Get
[2017-11-18 02:59:59.986] [I] [zway] Adding job: ManufacturerSpecific Version Get
[2017-11-18 02:59:59.986] [I] [zway] Adding job: Protection Version Get
[2017-11-18 02:59:59.987] [I] [zway] Adding job: NodeNaming Version Get
[2017-11-18 02:59:59.987] [I] [zway] Adding job: Association Version Get
[2017-11-18 02:59:59.987] [I] [zway] Adding job: Version Version Get
[2017-11-18 02:59:59.987] [I] [zway] Adding job: Indicator Version Get
[2017-11-18 02:59:59.988] [D] [zway] Running wakeup handler for node 2
[2017-11-18 02:59:59.988] [I] [zway] Adding job: Add/re-include node to network
[2017-11-18 02:59:59.988] [D] [zway] SENDING (cb 0x66): ( 01 05 00 4A 05 66 D3 )
[2017-11-18 02:59:59.989] [D] [zway] RECEIVED ACK
[2017-11-18 02:59:59.990] [I] [zway] Job 0x4a (Add/re-include node to network): Stop done
[2017-11-18 02:59:59.990] [D] [zway] Job 0x4a (Add/re-include node to network): success
[2017-11-18 02:59:59.990] [I] [zway] Removing job: Add/re-include node to network
[2017-11-18 02:59:59.991] [D] [zway] SETDATA controller.data.controllerState = 0 (0x00000000)
[2017-11-18 03:00:00.102] [D] [zway] RECEIVED: ( 01 07 00 4A 66 06 02 00 D0 )
[2017-11-18 03:00:00.102] [D] [zway] SENT ACK
[2017-11-18 03:00:00.103] [I] [zway] Job 0x4a (Add/re-include node to network): Done
[2017-11-18 03:00:00.103] [D] [zway] Job 0x4a (Add/re-include node to network): success
[2017-11-18 03:00:00.103] [I] [zway] Removing job: Add/re-include node to network
[2017-11-18 03:00:00.103] [I] [zway] Adding job: Add/re-include node to network
[2017-11-18 03:00:00.104] [D] [zway] SETDATA controller.data.controllerState = 0 (0x00000000)
[2017-11-18 03:00:00.104] [D] [zway] SENDING (cb 0x00): ( 01 05 00 4A 05 00 B5 )
[2017-11-18 03:00:00.112] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.113] [I] [zway] Job 0x4a (Add/re-include node to network): Stop done
[2017-11-18 03:00:00.113] [D] [zway] Job 0x4a (Add/re-include node to network): success
[2017-11-18 03:00:00.113] [I] [zway] Removing job: Add/re-include node to network
[2017-11-18 03:00:00.113] [D] [zway] SETDATA controller.data.controllerState = 0 (0x00000000)
[2017-11-18 03:00:00.124] [D] [zway] SENDING: ( 01 04 00 41 02 B8 )
[2017-11-18 03:00:00.125] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.134] [D] [zway] RECEIVED: ( 01 09 01 41 D3 9C 00 04 10 01 EC )
[2017-11-18 03:00:00.134] [D] [zway] SENT ACK
[2017-11-18 03:00:00.134] [D] [zway] SETDATA devices.2.data.basicType = 4 (0x00000004)
[2017-11-18 03:00:00.135] [D] [zway] SETDATA devices.2.data.genericType = 16 (0x00000010)
[2017-11-18 03:00:00.135] [D] [zway] SETDATA devices.2.data.specificType = 1 (0x00000001)
[2017-11-18 03:00:00.137] [D] [zway] SETDATA devices.2.data.deviceTypeString = "Binary Power Switch"
[2017-11-18 03:00:00.137] [D] [zway] SETDATA devices.2.data.isRouting = True
[2017-11-18 03:00:00.138] [D] [zway] SETDATA devices.2.data.isListening = True
[2017-11-18 03:00:00.138] [D] [zway] SETDATA devices.2.data.optional = True
[2017-11-18 03:00:00.138] [D] [zway] SETDATA devices.2.data.sensor1000 = False
[2017-11-18 03:00:00.138] [D] [zway] SETDATA devices.2.data.sensor250 = False
[2017-11-18 03:00:00.138] [D] [zway] SETDATA devices.2.data.infoProtocolSpecific = 13868032 (0x00d39c00)
[2017-11-18 03:00:00.139] [D] [zway] Job 0x41 (Get node protocol information): success
[2017-11-18 03:00:00.139] [I] [zway] Removing job: Get node protocol information
[2017-11-18 03:00:00.139] [D] [zway] SENDING: ( 01 06 00 80 01 00 00 78 )
[2017-11-18 03:00:00.145] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.145] [D] [zway] RECEIVED: ( 01 20 01 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 5E )
[2017-11-18 03:00:00.145] [D] [zway] SENT ACK
[2017-11-18 03:00:00.145] [D] [zway] SETDATA devices.1.data.neighbours = byte[0]
[2017-11-18 03:00:00.146] [D] [zway]   ( zero-length buffer )
[2017-11-18 03:00:00.146] [I] [zway] Job 0x80 (Get routing table line): List of neighbours for node 1: [ ]
[2017-11-18 03:00:00.146] [D] [zway] Job 0x80 (Get routing table line): success
[2017-11-18 03:00:00.146] [I] [zway] Removing job: Get routing table line
[2017-11-18 03:00:00.147] [D] [zway] SENDING: ( 01 06 00 80 04 00 00 7D )
[2017-11-18 03:00:00.155] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.155] [D] [zway] RECEIVED: ( 01 20 01 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 5E )
[2017-11-18 03:00:00.156] [D] [zway] SENT ACK
[2017-11-18 03:00:00.156] [D] [zway] SETDATA devices.4.data.neighbours = byte[0]
[2017-11-18 03:00:00.156] [D] [zway]   ( zero-length buffer )
[2017-11-18 03:00:00.156] [I] [zway] Job 0x80 (Get routing table line): List of neighbours for node 4: [ ]
[2017-11-18 03:00:00.157] [D] [zway] Job 0x80 (Get routing table line): success
[2017-11-18 03:00:00.157] [I] [zway] Removing job: Get routing table line
[2017-11-18 03:00:00.157] [D] [zway] SENDING: ( 01 06 00 80 02 00 00 7B )
[2017-11-18 03:00:00.165] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.166] [D] [zway] RECEIVED: ( 01 20 01 80 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 5E )
[2017-11-18 03:00:00.166] [D] [zway] SENT ACK
[2017-11-18 03:00:00.166] [D] [zway] SETDATA devices.2.data.neighbours = byte[0]
[2017-11-18 03:00:00.166] [D] [zway]   ( zero-length buffer )
[2017-11-18 03:00:00.167] [I] [zway] Job 0x80 (Get routing table line): List of neighbours for node 2: [ ]
[2017-11-18 03:00:00.167] [D] [zway] Job 0x80 (Get routing table line): success
[2017-11-18 03:00:00.167] [I] [zway] Removing job: Get routing table line
[2017-11-18 03:00:00.167] [D] [zway] SENDING (cb 0x67): ( 01 0A 00 13 02 03 86 13 20 25 67 10 )
[2017-11-18 03:00:00.175] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:00.176] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:00.176] [D] [zway] SENT ACK
[2017-11-18 03:00:00.183] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:04.256] [D] [zway] RECEIVED: ( 01 07 00 13 67 01 01 97 1B )
[2017-11-18 03:00:04.257] [D] [zway] SENT ACK
[2017-11-18 03:00:04.258] [I] [zway] Job 0x13 (Basic Version Get): Not delivered to recipient
[2017-11-18 03:00:04.259] [D] [zway] SENDING (cb 0x68): ( 01 0A 00 13 02 03 86 13 20 25 68 1F )
[2017-11-18 03:00:04.266] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:04.268] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:04.269] [D] [zway] SENT ACK
[2017-11-18 03:00:04.269] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:08.374] [D] [zway] RECEIVED: ( 01 07 00 13 68 01 01 9B 18 )
[2017-11-18 03:00:08.375] [D] [zway] SENT ACK
[2017-11-18 03:00:08.375] [I] [zway] Job 0x13 (Basic Version Get): Not delivered to recipient
[2017-11-18 03:00:08.376] [D] [zway] SENDING (cb 0x69): ( 01 0A 00 13 02 03 86 13 20 25 69 1E )
[2017-11-18 03:00:08.384] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:08.385] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:08.386] [D] [zway] SENT ACK
[2017-11-18 03:00:08.387] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:12.554] [D] [zway] RECEIVED: ( 01 07 00 13 69 01 01 A0 22 )
[2017-11-18 03:00:12.555] [D] [zway] SENT ACK
[2017-11-18 03:00:12.555] [I] [zway] Job 0x13 (Basic Version Get): Not delivered to recipient
[2017-11-18 03:00:12.556] [I] [zway] Job 0x13 (Basic Version Get): Removing job due to too much retransmitions
[2017-11-18 03:00:12.557] [D] [zway] SETDATA devices.2.data.failureCount = 1 (0x00000001)
[2017-11-18 03:00:12.557] [D] [zway] SETDATA devices.2.data.lastSendInternal = **********
[2017-11-18 03:00:12.558] [D] [zway] Job 0x13 (Basic Version Get): fail
[2017-11-18 03:00:12.558] [I] [zway] Waiting for job reply: Basic Version Get
[2017-11-18 03:00:12.656] [D] [zway] Job 0x62: deleted from queue
[2017-11-18 03:00:14.689] [W] [zway] Reply not received before timeout for job (Basic Version Get)
[2017-11-18 03:00:15.661] [D] [zway] SENDING (cb 0x6a): ( 01 0A 00 13 02 03 86 13 25 25 6A 18 )
[2017-11-18 03:00:15.663] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:15.670] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:15.671] [D] [zway] SENT ACK
[2017-11-18 03:00:15.671] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:19.787] [D] [zway] RECEIVED: ( 01 07 00 13 6A 01 01 9C 1D )
[2017-11-18 03:00:19.808] [D] [zway] SENT ACK
[2017-11-18 03:00:19.809] [I] [zway] Job 0x13 (SwitchBinary Version Get): Not delivered to recipient
[2017-11-18 03:00:19.810] [D] [zway] SENDING (cb 0x6b): ( 01 0A 00 13 02 03 86 13 25 25 6B 19 )
[2017-11-18 03:00:19.812] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:19.819] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:19.820] [D] [zway] SENT ACK
[2017-11-18 03:00:19.820] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:20.332] [D] [zway] Job 0x4a: deleted from queue
[2017-11-18 03:00:20.445] [D] [zway] Job 0x4a: deleted from queue
[2017-11-18 03:00:20.446] [D] [zway] Job 0x4a: deleted from queue
[2017-11-18 03:00:20.456] [D] [zway] Job 0x41: deleted from queue
[2017-11-18 03:00:20.467] [D] [zway] Job 0x80: deleted from queue
[2017-11-18 03:00:20.468] [D] [zway] Job 0x80: deleted from queue
[2017-11-18 03:00:20.468] [D] [zway] Job 0x80: deleted from queue
[2017-11-18 03:00:23.974] [D] [zway] RECEIVED: ( 01 07 00 13 6B 01 01 9F 1F )
[2017-11-18 03:00:23.974] [D] [zway] SENT ACK
[2017-11-18 03:00:23.974] [I] [zway] Job 0x13 (SwitchBinary Version Get): Not delivered to recipient
[2017-11-18 03:00:23.975] [D] [zway] SENDING (cb 0x6c): ( 01 0A 00 13 02 03 86 13 25 25 6C 1E )
[2017-11-18 03:00:23.984] [D] [zway] RECEIVED ACK
[2017-11-18 03:00:23.985] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2017-11-18 03:00:23.985] [D] [zway] SENT ACK
[2017-11-18 03:00:23.985] [D] [zway] Delivered to Z-Wave stack
[2017-11-18 03:00:28.108] [D] [zway] RECEIVED: ( 01 07 00 13 6C 01 01 9C 1B )
[2017-11-18 03:00:28.108] [D] [zway] SENT ACK
[2017-11-18 03:00:28.108] [I] [zway] Job 0x13 (SwitchBinary Version Get): Not delivered to recipient
[2017-11-18 03:00:28.109] [I] [zway] Job 0x13 (SwitchBinary Version Get): Removing job due to too much retransmitions
[2017-11-18 03:00:28.109] [D] [zway] SETDATA devices.2.data.failureCount = 2 (0x00000002)
[2017-11-18 03:00:28.110] [D] [zway] SETDATA devices.2.data.lastSendInternal = **********
[2017-11-18 03:00:28.110] [D] [zway] Job 0x13 (SwitchBinary Version Get): fail
[2017-11-18 03:00:28.110] [I] [zway] Waiting for job reply: SwitchBinary Version Get
[2017-11-18 03:00:28.128] [I] [core] Notification: error (connection): Connection lost to Z-Wave device ID: 2
[2017-11-18 03:00:30.240] [W] [zway] Reply not received before timeout for job (SwitchBinary Version Get)
[2017-11-18 03:00:34.981] [D] [zway] Job 0x13: deleted from queue
With manual force the only interview that finishes successfully is Configuration:

Code: Select all

[2017-11-18 03:02:04.370] [I] [zway] Waiting for job reply: Configuration Version Get
[2017-11-18 03:02:06.491] [W] [zway] Reply not received before timeout for job (Configuration Version Get)
[2017-11-18 03:02:08.586] [D] [zway] SETDATA devices.2.instances.0.commandClasses.112.data.interviewDone = True
[2017-11-18 03:02:08.587] [I] [zway] Node 2:0 CC Configuration Interview done

Post Reply

Who is online

Users browsing this forum: No registered users and 11 guests