Vision Siren can't complete interview
Posted: 08 Jan 2016 15:09
Cant complete force interview with vision siren in secure mode, in insecure mode the interview will completed.
Thanks for help.
log:
[2016-01-08 13:02:22.412] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:22.412] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:22.412] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 14 86 02 ]
[2016-01-08 13:02:22.413] [zway] Adding job: Version Get
[2016-01-08 13:02:22.413] [zway] Node 30:0 CC Version: Version is v2
[2016-01-08 13:02:22.413] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.version = 2 (0x00000002)
[2016-01-08 13:02:22.462] [D] [zway] SENDING (cb 0x57): ( 01 09 00 13 1E 02 98 40 05 57 73 )
[2016-01-08 13:02:22.464] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.467] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.468] [D] [zway] SENT ACK
[2016-01-08 13:02:22.468] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.492] [D] [zway] RECEIVED: ( 01 07 00 13 57 00 00 02 BE )
[2016-01-08 13:02:22.493] [D] [zway] SENT ACK
[2016-01-08 13:02:22.493] [zway] Job 0x13 (Nonce Get): Delivered
[2016-01-08 13:02:22.493] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.493] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 24 (0x00000018)
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.494] [D] [zway] SendData Response with callback 0x57 received: received by recipient
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastSend = 1039916 (0x000fde2c)
[2016-01-08 13:02:22.495] [D] [zway] Job 0x13 (Nonce Get): success
[2016-01-08 13:02:22.495] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.495] [zway] Removing job: Nonce Get
[2016-01-08 13:02:22.503] [D] [zway] RECEIVED: ( 01 10 00 04 00 1E 0A 98 80 B9 FD D3 22 4D 8E D7 DB 9D )
[2016-01-08 13:02:22.503] [D] [zway] SENT ACK
[2016-01-08 13:02:22.503] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.504] [zway] Node 30:0 CC Security: received Nonce Report
[2016-01-08 13:02:22.504] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonce = **********
[2016-01-08 13:02:22.504] [zway] Removing job: Security Version Get
[2016-01-08 13:02:22.504] [zway] Node 30:0 CC Security: Sending a secure message
[2016-01-08 13:02:22.505] [zway] Node 30:0 CC Security: sending encrypted packet: Security Version Get
[2016-01-08 13:02:22.505] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.toFollow = False
[2016-01-08 13:02:22.505] [D] [zway] SETDATA devices.30.data.lastNonceGet = Empty
[2016-01-08 13:02:22.506] [I] [zway] Adding job: Security, Security Version Get
[2016-01-08 13:02:22.506] [I] [zway] Node 30:0 CC Security: sending Nonce Get
[2016-01-08 13:02:22.507] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.507] [I] [zway] Adding job: Nonce Get
[2016-01-08 13:02:22.507] [D] [zway] SETDATA devices.30.data.lastNonceGet = 1039917 (0x000fde2d)
[2016-01-08 13:02:22.566] [D] [zway] SENDING (cb 0x58): ( 01 1E 00 13 1E 17 98 81 73 EC FF 3F 66 22 BC F1 75 60 72 66 B9 BB CE AF 0C 2B 2D 0C 84 05 58 09 )
[2016-01-08 13:02:22.569] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.574] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.574] [D] [zway] SENT ACK
[2016-01-08 13:02:22.574] [I] [zway] Job 0x13 (Security, Security Version Get): Response received - transfered to encapsulated jobs
[2016-01-08 13:02:22.575] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.575] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.597] [D] [zway] RECEIVED: ( 01 07 00 13 58 00 00 03 B0 )
[2016-01-08 13:02:22.598] [D] [zway] SENT ACK
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security, Security Version Get): Callback received - transfered to encapsulated jobs
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security Version Get): Delivered
[2016-01-08 13:02:22.598] [D] [zway] SendData Response with callback 0x58 received: received by recipient
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security, Security Version Get): Delivered
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 26 (0x0000001a)
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 23 (0x00000017)
[2016-01-08 13:02:22.600] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.600] [D] [zway] SendData Response with callback 0x58 received: received by recipient
[2016-01-08 13:02:22.600] [D] [zway] SETDATA devices.30.data.lastSend = 1039926 (0x000fde36)
[2016-01-08 13:02:22.600] [D] [zway] Job 0x13 (Security, Security Version Get): success
[2016-01-08 13:02:22.601] [I] [zway] Removing job: Security, Security Version Get
[2016-01-08 13:02:22.617] [D] [zway] RECEIVED: ( 01 08 00 04 00 1E 02 98 40 37 )
[2016-01-08 13:02:22.617] [D] [zway] SENT ACK
[2016-01-08 13:02:22.618] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.618] [I] [zway] Node 30:0 CC Security: sending Nonce Report
[2016-01-08 13:02:22.619] [I] [zway] Adding job: Nonce Report
[2016-01-08 13:02:22.669] [D] [zway] SENDING (cb 0x59): ( 01 11 00 13 1E 0A 98 80 63 92 5C B4 37 D4 18 08 05 59 47 )
[2016-01-08 13:02:22.672] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.676] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.676] [D] [zway] SENT ACK
[2016-01-08 13:02:22.677] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.697] [D] [zway] RECEIVED: ( 01 07 00 13 59 00 00 02 B0 )
[2016-01-08 13:02:22.697] [D] [zway] SENT ACK
[2016-01-08 13:02:22.697] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 20 (0x00000014)
[2016-01-08 13:02:22.699] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.699] [D] [zway] SendData Response with callback 0x59 received: received by recipient
[2016-01-08 13:02:22.699] [D] [zway] SETDATA devices.30.data.lastSend = 1039935 (0x000fde3f)
[2016-01-08 13:02:22.700] [D] [zway] Job 0x13 (Nonce Report): success
[2016-01-08 13:02:22.700] [I] [zway] Removing job: Nonce Report
[2016-01-08 13:02:22.723] [D] [zway] RECEIVED: ( 01 1E 00 04 00 1E 18 98 81 1F 45 F7 85 7C 5D C4 8D 27 31 73 A7 D9 63 8F 2A AA BF 1B 99 17 0A ED )
[2016-01-08 13:02:22.723] [D] [zway] SENT ACK
[2016-01-08 13:02:22.723] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.724] [I] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:22.724] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:22.724] [I] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 14 98 01 ]
[2016-01-08 13:02:22.725] [I] [zway] Node 30:0 CC Version: Security is v1
[2016-01-08 13:02:22.725] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.version = 1 (0x00000001)
[2016-01-08 13:02:22.765] [D] [zway] SENDING (cb 0x5a): ( 01 09 00 13 1E 02 98 40 05 5A 7E )
[2016-01-08 13:02:22.767] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.771] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.771] [D] [zway] SENT ACK
[2016-01-08 13:02:22.771] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.795] [D] [zway] RECEIVED: ( 01 07 00 13 5A 00 00 02 B3 )
[2016-01-08 13:02:22.796] [D] [zway] SENT ACK
[2016-01-08 13:02:22.796] [I] [zway] Job 0x13 (Nonce Get): Delivered
[2016-01-08 13:02:22.796] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.796] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 24 (0x00000018)
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.797] [D] [zway] SendData Response with callback 0x5a received: received by recipient
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastSend = 1039945 (0x000fde49)
[2016-01-08 13:02:22.798] [D] [zway] Job 0x13 (Nonce Get): success
[2016-01-08 13:02:22.798] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.798] [I] [zway] Removing job: Nonce Get
[2016-01-08 13:02:22.806] [D] [zway] RECEIVED: ( 01 10 00 04 00 1E 0A 98 80 C1 EB DD 96 65 3B E6 E7 D9 )
[2016-01-08 13:02:22.806] [D] [zway] SENT ACK
[2016-01-08 13:02:22.806] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.807] [I] [zway] Node 30:0 CC Security: received Nonce Report
[2016-01-08 13:02:22.807] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonce = **********
[2016-01-08 13:02:22.807] [I] [zway] Removing job: Version Get
[2016-01-08 13:02:22.807] [I] [zway] Node 30:0 CC Security: Sending a secure message
[2016-01-08 13:02:22.808] [I] [zway] Node 30:0 CC Security: sending encrypted packet: Version Get
[2016-01-08 13:02:22.808] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.toFollow = False
[2016-01-08 13:02:22.808] [D] [zway] SETDATA devices.30.data.lastNonceGet = Empty
[2016-01-08 13:02:22.809] [I] [zway] Adding job: Security, Version Get
[2016-01-08 13:02:22.869] [D] [zway] SENDING (cb 0x5b): ( 01 1D 00 13 1E 16 98 81 E4 D6 9F 0F 2E 20 48 C2 02 8A 5C C1 51 47 F4 CC 0D 21 69 EE 05 5B 08 )
[2016-01-08 13:02:22.872] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.877] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.877] [D] [zway] SENT ACK
[2016-01-08 13:02:22.877] [I] [zway] Job 0x13 (Security, Version Get): Response received - transfered to encapsulated jobs
[2016-01-08 13:02:22.877] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.878] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.900] [D] [zway] RECEIVED: ( 01 07 00 13 5B 00 00 02 B2 )
[2016-01-08 13:02:22.900] [D] [zway] SENT ACK
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Security, Version Get): Callback received - transfered to encapsulated jobs
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Version Get): Delivered
[2016-01-08 13:02:22.901] [D] [zway] SendData Response with callback 0x5b received: received by recipient
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Security, Version Get): Delivered
[2016-01-08 13:02:22.901] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 25 (0x00000019)
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 23 (0x00000017)
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.903] [D] [zway] SendData Response with callback 0x5b received: received by recipient
[2016-01-08 13:02:22.903] [D] [zway] SETDATA devices.30.data.lastSend = 1039955 (0x000fde53)
[2016-01-08 13:02:22.903] [D] [zway] Job 0x13 (Security, Version Get): success
[2016-01-08 13:02:22.903] [I] [zway] Removing job: Security, Version Get
[2016-01-08 13:02:22.921] [D] [zway] RECEIVED: ( 01 08 00 04 00 1E 02 98 40 37 )
[2016-01-08 13:02:22.921] [D] [zway] SENT ACK
[2016-01-08 13:02:22.921] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.922] [I] [zway] Node 30:0 CC Security: sending Nonce Report
[2016-01-08 13:02:22.922] [I] [zway] Adding job: Nonce Report
[2016-01-08 13:02:22.972] [D] [zway] SENDING (cb 0x5c): ( 01 11 00 13 1E 0A 98 80 BA 09 4D F7 DD 5A 44 ED 05 5C 8F )
[2016-01-08 13:02:22.974] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.979] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.979] [D] [zway] SENT ACK
[2016-01-08 13:02:22.979] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.999] [D] [zway] RECEIVED: ( 01 07 00 13 5C 00 00 02 B5 )
[2016-01-08 13:02:23.000] [D] [zway] SENT ACK
[2016-01-08 13:02:23.000] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2016-01-08 13:02:23.000] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:23.000] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-01-08 13:02:23.001] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 21 (0x00000015)
[2016-01-08 13:02:23.001] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:23.001] [D] [zway] SendData Response with callback 0x5c received: received by recipient
[2016-01-08 13:02:23.002] [D] [zway] SETDATA devices.30.data.lastSend = 1039964 (0x000fde5c)
[2016-01-08 13:02:23.002] [D] [zway] Job 0x13 (Nonce Report): success
[2016-01-08 13:02:23.002] [I] [zway] Removing job: Nonce Report
[2016-01-08 13:02:23.023] [D] [zway] RECEIVED: ( 01 25 00 04 00 1E 1F 98 81 F5 CE CA AC 6F 4B 02 1C 3A 0C 28 2B 53 26 F9 9D 07 F0 23 4A BA 19 72 71 16 C3 FA 54 35 F5 )
[2016-01-08 13:02:23.024] [D] [zway] SENT ACK
[2016-01-08 13:02:23.024] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:23.024] [I] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:23.025] [I] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 12 03 04 05 0f 03 02 02 05 01 ]
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data = Empty
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWLib = 3 (0x00000003)
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWProtocolMajor = 4 (0x00000004)
[2016-01-08 13:02:23.026] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWProtocolMinor = 5 (0x00000005)
[2016-01-08 13:02:23.029] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.SDK = "6.51.06"
[2016-01-08 13:02:23.029] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.applicationMajor = 15 (0x0000000f)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.applicationMinor = 3 (0x00000003)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWLib = 3 (0x00000003)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWProtocolMajor = 4 (0x00000004)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWProtocolMinor = 5 (0x00000005)
[2016-01-08 13:02:23.033] [D] [zway] SETDATA devices.30.data.SDK = "6.51.06"
[2016-01-08 13:02:23.034] [D] [zway] SETDATA devices.30.data.applicationMajor = 15 (0x0000000f)
[2016-01-08 13:02:23.034] [D] [zway] SETDATA devices.30.data.applicationMinor = 3 (0x00000003)
[2016-01-08 13:02:23.034] [E] [zway] Packet CC::VERSION_REPORT (v2) is too short: required at least 13 bytes, got 11
[2016-01-08 13:02:23.034] [E] [zway] Error returned from _zway_cc_call_handler(zway, command, controller->id, 0, data[4], &data[5]): Wrong packet from Z-Wave network or Discovery got bad data (stick communication failed) (-9)
Thanks for help.
log:
[2016-01-08 13:02:22.412] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:22.412] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:22.412] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 14 86 02 ]
[2016-01-08 13:02:22.413] [zway] Adding job: Version Get
[2016-01-08 13:02:22.413] [zway] Node 30:0 CC Version: Version is v2
[2016-01-08 13:02:22.413] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.version = 2 (0x00000002)
[2016-01-08 13:02:22.462] [D] [zway] SENDING (cb 0x57): ( 01 09 00 13 1E 02 98 40 05 57 73 )
[2016-01-08 13:02:22.464] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.467] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.468] [D] [zway] SENT ACK
[2016-01-08 13:02:22.468] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.492] [D] [zway] RECEIVED: ( 01 07 00 13 57 00 00 02 BE )
[2016-01-08 13:02:22.493] [D] [zway] SENT ACK
[2016-01-08 13:02:22.493] [zway] Job 0x13 (Nonce Get): Delivered
[2016-01-08 13:02:22.493] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.493] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 24 (0x00000018)
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.494] [D] [zway] SendData Response with callback 0x57 received: received by recipient
[2016-01-08 13:02:22.494] [D] [zway] SETDATA devices.30.data.lastSend = 1039916 (0x000fde2c)
[2016-01-08 13:02:22.495] [D] [zway] Job 0x13 (Nonce Get): success
[2016-01-08 13:02:22.495] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.495] [zway] Removing job: Nonce Get
[2016-01-08 13:02:22.503] [D] [zway] RECEIVED: ( 01 10 00 04 00 1E 0A 98 80 B9 FD D3 22 4D 8E D7 DB 9D )
[2016-01-08 13:02:22.503] [D] [zway] SENT ACK
[2016-01-08 13:02:22.503] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.504] [zway] Node 30:0 CC Security: received Nonce Report
[2016-01-08 13:02:22.504] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonce = **********
[2016-01-08 13:02:22.504] [zway] Removing job: Security Version Get
[2016-01-08 13:02:22.504] [zway] Node 30:0 CC Security: Sending a secure message
[2016-01-08 13:02:22.505] [zway] Node 30:0 CC Security: sending encrypted packet: Security Version Get
[2016-01-08 13:02:22.505] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.toFollow = False
[2016-01-08 13:02:22.505] [D] [zway] SETDATA devices.30.data.lastNonceGet = Empty
[2016-01-08 13:02:22.506] [I] [zway] Adding job: Security, Security Version Get
[2016-01-08 13:02:22.506] [I] [zway] Node 30:0 CC Security: sending Nonce Get
[2016-01-08 13:02:22.507] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.507] [I] [zway] Adding job: Nonce Get
[2016-01-08 13:02:22.507] [D] [zway] SETDATA devices.30.data.lastNonceGet = 1039917 (0x000fde2d)
[2016-01-08 13:02:22.566] [D] [zway] SENDING (cb 0x58): ( 01 1E 00 13 1E 17 98 81 73 EC FF 3F 66 22 BC F1 75 60 72 66 B9 BB CE AF 0C 2B 2D 0C 84 05 58 09 )
[2016-01-08 13:02:22.569] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.574] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.574] [D] [zway] SENT ACK
[2016-01-08 13:02:22.574] [I] [zway] Job 0x13 (Security, Security Version Get): Response received - transfered to encapsulated jobs
[2016-01-08 13:02:22.575] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.575] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.597] [D] [zway] RECEIVED: ( 01 07 00 13 58 00 00 03 B0 )
[2016-01-08 13:02:22.598] [D] [zway] SENT ACK
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security, Security Version Get): Callback received - transfered to encapsulated jobs
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security Version Get): Delivered
[2016-01-08 13:02:22.598] [D] [zway] SendData Response with callback 0x58 received: received by recipient
[2016-01-08 13:02:22.598] [I] [zway] Job 0x13 (Security, Security Version Get): Delivered
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 26 (0x0000001a)
[2016-01-08 13:02:22.599] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 23 (0x00000017)
[2016-01-08 13:02:22.600] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.600] [D] [zway] SendData Response with callback 0x58 received: received by recipient
[2016-01-08 13:02:22.600] [D] [zway] SETDATA devices.30.data.lastSend = 1039926 (0x000fde36)
[2016-01-08 13:02:22.600] [D] [zway] Job 0x13 (Security, Security Version Get): success
[2016-01-08 13:02:22.601] [I] [zway] Removing job: Security, Security Version Get
[2016-01-08 13:02:22.617] [D] [zway] RECEIVED: ( 01 08 00 04 00 1E 02 98 40 37 )
[2016-01-08 13:02:22.617] [D] [zway] SENT ACK
[2016-01-08 13:02:22.618] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.618] [I] [zway] Node 30:0 CC Security: sending Nonce Report
[2016-01-08 13:02:22.619] [I] [zway] Adding job: Nonce Report
[2016-01-08 13:02:22.669] [D] [zway] SENDING (cb 0x59): ( 01 11 00 13 1E 0A 98 80 63 92 5C B4 37 D4 18 08 05 59 47 )
[2016-01-08 13:02:22.672] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.676] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.676] [D] [zway] SENT ACK
[2016-01-08 13:02:22.677] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.697] [D] [zway] RECEIVED: ( 01 07 00 13 59 00 00 02 B0 )
[2016-01-08 13:02:22.697] [D] [zway] SENT ACK
[2016-01-08 13:02:22.697] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-01-08 13:02:22.698] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 20 (0x00000014)
[2016-01-08 13:02:22.699] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.699] [D] [zway] SendData Response with callback 0x59 received: received by recipient
[2016-01-08 13:02:22.699] [D] [zway] SETDATA devices.30.data.lastSend = 1039935 (0x000fde3f)
[2016-01-08 13:02:22.700] [D] [zway] Job 0x13 (Nonce Report): success
[2016-01-08 13:02:22.700] [I] [zway] Removing job: Nonce Report
[2016-01-08 13:02:22.723] [D] [zway] RECEIVED: ( 01 1E 00 04 00 1E 18 98 81 1F 45 F7 85 7C 5D C4 8D 27 31 73 A7 D9 63 8F 2A AA BF 1B 99 17 0A ED )
[2016-01-08 13:02:22.723] [D] [zway] SENT ACK
[2016-01-08 13:02:22.723] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.724] [I] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:22.724] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:22.724] [I] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 14 98 01 ]
[2016-01-08 13:02:22.725] [I] [zway] Node 30:0 CC Version: Security is v1
[2016-01-08 13:02:22.725] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.version = 1 (0x00000001)
[2016-01-08 13:02:22.765] [D] [zway] SENDING (cb 0x5a): ( 01 09 00 13 1E 02 98 40 05 5A 7E )
[2016-01-08 13:02:22.767] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.771] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.771] [D] [zway] SENT ACK
[2016-01-08 13:02:22.771] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.795] [D] [zway] RECEIVED: ( 01 07 00 13 5A 00 00 02 B3 )
[2016-01-08 13:02:22.796] [D] [zway] SENT ACK
[2016-01-08 13:02:22.796] [I] [zway] Job 0x13 (Nonce Get): Delivered
[2016-01-08 13:02:22.796] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.796] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 24 (0x00000018)
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.797] [D] [zway] SendData Response with callback 0x5a received: received by recipient
[2016-01-08 13:02:22.797] [D] [zway] SETDATA devices.30.data.lastSend = 1039945 (0x000fde49)
[2016-01-08 13:02:22.798] [D] [zway] Job 0x13 (Nonce Get): success
[2016-01-08 13:02:22.798] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonceAckWait = **********
[2016-01-08 13:02:22.798] [I] [zway] Removing job: Nonce Get
[2016-01-08 13:02:22.806] [D] [zway] RECEIVED: ( 01 10 00 04 00 1E 0A 98 80 C1 EB DD 96 65 3B E6 E7 D9 )
[2016-01-08 13:02:22.806] [D] [zway] SENT ACK
[2016-01-08 13:02:22.806] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.807] [I] [zway] Node 30:0 CC Security: received Nonce Report
[2016-01-08 13:02:22.807] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.rNonce = **********
[2016-01-08 13:02:22.807] [I] [zway] Removing job: Version Get
[2016-01-08 13:02:22.807] [I] [zway] Node 30:0 CC Security: Sending a secure message
[2016-01-08 13:02:22.808] [I] [zway] Node 30:0 CC Security: sending encrypted packet: Version Get
[2016-01-08 13:02:22.808] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.toFollow = False
[2016-01-08 13:02:22.808] [D] [zway] SETDATA devices.30.data.lastNonceGet = Empty
[2016-01-08 13:02:22.809] [I] [zway] Adding job: Security, Version Get
[2016-01-08 13:02:22.869] [D] [zway] SENDING (cb 0x5b): ( 01 1D 00 13 1E 16 98 81 E4 D6 9F 0F 2E 20 48 C2 02 8A 5C C1 51 47 F4 CC 0D 21 69 EE 05 5B 08 )
[2016-01-08 13:02:22.872] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.877] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.877] [D] [zway] SENT ACK
[2016-01-08 13:02:22.877] [I] [zway] Job 0x13 (Security, Version Get): Response received - transfered to encapsulated jobs
[2016-01-08 13:02:22.877] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.878] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.900] [D] [zway] RECEIVED: ( 01 07 00 13 5B 00 00 02 B2 )
[2016-01-08 13:02:22.900] [D] [zway] SENT ACK
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Security, Version Get): Callback received - transfered to encapsulated jobs
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Version Get): Delivered
[2016-01-08 13:02:22.901] [D] [zway] SendData Response with callback 0x5b received: received by recipient
[2016-01-08 13:02:22.901] [I] [zway] Job 0x13 (Security, Version Get): Delivered
[2016-01-08 13:02:22.901] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 25 (0x00000019)
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 23 (0x00000017)
[2016-01-08 13:02:22.902] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:22.903] [D] [zway] SendData Response with callback 0x5b received: received by recipient
[2016-01-08 13:02:22.903] [D] [zway] SETDATA devices.30.data.lastSend = 1039955 (0x000fde53)
[2016-01-08 13:02:22.903] [D] [zway] Job 0x13 (Security, Version Get): success
[2016-01-08 13:02:22.903] [I] [zway] Removing job: Security, Version Get
[2016-01-08 13:02:22.921] [D] [zway] RECEIVED: ( 01 08 00 04 00 1E 02 98 40 37 )
[2016-01-08 13:02:22.921] [D] [zway] SENT ACK
[2016-01-08 13:02:22.921] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:22.922] [I] [zway] Node 30:0 CC Security: sending Nonce Report
[2016-01-08 13:02:22.922] [I] [zway] Adding job: Nonce Report
[2016-01-08 13:02:22.972] [D] [zway] SENDING (cb 0x5c): ( 01 11 00 13 1E 0A 98 80 BA 09 4D F7 DD 5A 44 ED 05 5C 8F )
[2016-01-08 13:02:22.974] [D] [zway] RECEIVED ACK
[2016-01-08 13:02:22.979] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-01-08 13:02:22.979] [D] [zway] SENT ACK
[2016-01-08 13:02:22.979] [D] [zway] Delivered to Z-Wave stack
[2016-01-08 13:02:22.999] [D] [zway] RECEIVED: ( 01 07 00 13 5C 00 00 02 B5 )
[2016-01-08 13:02:23.000] [D] [zway] SENT ACK
[2016-01-08 13:02:23.000] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2016-01-08 13:02:23.000] [D] [zway] SETDATA devices.30.data.lastPacketInfo.delivered = True
[2016-01-08 13:02:23.000] [D] [zway] SETDATA devices.30.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-01-08 13:02:23.001] [D] [zway] SETDATA devices.30.data.lastPacketInfo.deliveryTime = 21 (0x00000015)
[2016-01-08 13:02:23.001] [D] [zway] SETDATA devices.30.data.lastPacketInfo = **********
[2016-01-08 13:02:23.001] [D] [zway] SendData Response with callback 0x5c received: received by recipient
[2016-01-08 13:02:23.002] [D] [zway] SETDATA devices.30.data.lastSend = 1039964 (0x000fde5c)
[2016-01-08 13:02:23.002] [D] [zway] Job 0x13 (Nonce Report): success
[2016-01-08 13:02:23.002] [I] [zway] Removing job: Nonce Report
[2016-01-08 13:02:23.023] [D] [zway] RECEIVED: ( 01 25 00 04 00 1E 1F 98 81 F5 CE CA AC 6F 4B 02 1C 3A 0C 28 2B 53 26 F9 9D 07 F0 23 4A BA 19 72 71 16 C3 FA 54 35 F5 )
[2016-01-08 13:02:23.024] [D] [zway] SENT ACK
[2016-01-08 13:02:23.024] [D] [zway] SETDATA devices.30.data.lastReceived = 0 (0x00000000)
[2016-01-08 13:02:23.024] [I] [zway] Node 30:0 CC Security: Received a secure message
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.152.data.firstPart = **********
[2016-01-08 13:02:23.025] [I] [zway] Node 30:0 CC Security: passing decrypted packet to application level: [ 86 12 03 04 05 0f 03 02 02 05 01 ]
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data = Empty
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWLib = 3 (0x00000003)
[2016-01-08 13:02:23.025] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWProtocolMajor = 4 (0x00000004)
[2016-01-08 13:02:23.026] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.ZWProtocolMinor = 5 (0x00000005)
[2016-01-08 13:02:23.029] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.SDK = "6.51.06"
[2016-01-08 13:02:23.029] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.applicationMajor = 15 (0x0000000f)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.instances.0.commandClasses.134.data.applicationMinor = 3 (0x00000003)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWLib = 3 (0x00000003)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWProtocolMajor = 4 (0x00000004)
[2016-01-08 13:02:23.030] [D] [zway] SETDATA devices.30.data.ZWProtocolMinor = 5 (0x00000005)
[2016-01-08 13:02:23.033] [D] [zway] SETDATA devices.30.data.SDK = "6.51.06"
[2016-01-08 13:02:23.034] [D] [zway] SETDATA devices.30.data.applicationMajor = 15 (0x0000000f)
[2016-01-08 13:02:23.034] [D] [zway] SETDATA devices.30.data.applicationMinor = 3 (0x00000003)
[2016-01-08 13:02:23.034] [E] [zway] Packet CC::VERSION_REPORT (v2) is too short: required at least 13 bytes, got 11
[2016-01-08 13:02:23.034] [E] [zway] Error returned from _zway_cc_call_handler(zway, command, controller->id, 0, data[4], &data[5]): Wrong packet from Z-Wave network or Discovery got bad data (stick communication failed) (-9)