fibaro sensor motion v3.2 encryption issue

[zwavedistran]

Hi

I got a PI and a RaZberry. (chip ZW0500)

API Firmware 5.03
Zwave.ME v 2.2.2

I got 2 type of FIBARO Sensor Motion : v2.7 and v3.2 (it is same model but with different version)

When using v2.7; i can see in log the OFF and ON events as well.
When using v3.2, i got some log but never OFF / ON events.

The issue looks like related to security :

[2016-05-04 09:19:47.378] [W] [zway] Node 22:0 CC Security: can not decrypt packet due to nonce lookup problem

Full log stack:


[2016-05-04 09:19:47.289] [D] [zway] RECEIVED: ( 01 08 00 04 00 16 02 98 40 3F )
[2016-05-04 09:19:47.291] [D] [zway] SENT ACK
[2016-05-04 09:19:47.292] [D] [zway] SETDATA devices.22.data.lastReceived = 0 (0x00000000)
[2016-05-04 09:19:47.294] [zway] Node 22:0 CC Security: sending Nonce Report
[2016-05-04 09:19:47.295] [zway] Adding job: Nonce Report
[2016-05-04 09:19:47.296] [D] [zway] SENDING (cb 0x16): ( 01 11 00 13 16 0A 98 80 CF F0 4E EF D0 D7 41 FD 05 16 CF )
[2016-05-04 09:19:47.300] [D] [zway] RECEIVED ACK
[2016-05-04 09:19:47.304] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-05-04 09:19:47.305] [D] [zway] SENT ACK
[2016-05-04 09:19:47.306] [D] [zway] Delivered to Z-Wave stack
[2016-05-04 09:19:47.320] [D] [zway] RECEIVED: ( 01 07 00 13 16 00 00 02 FF )
[2016-05-04 09:19:47.321] [D] [zway] SENT ACK
[2016-05-04 09:19:47.322] [zway] Job 0x13 (Nonce Report): Delivered
[2016-05-04 09:19:47.323] [D] [zway] SETDATA devices.22.data.lastPacketInfo.delivered = True
[2016-05-04 09:19:47.324] [D] [zway] SETDATA devices.22.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-05-04 09:19:47.325] [D] [zway] SETDATA devices.22.data.lastPacketInfo.deliveryTime = 15 (0x0000000f)
[2016-05-04 09:19:47.326] [D] [zway] SETDATA devices.22.data.lastPacketInfo = **********
[2016-05-04 09:19:47.326] [D] [zway] SendData Response with callback 0x16 received: received by recipient
[2016-05-04 09:19:47.327] [D] [zway] SETDATA devices.22.data.lastSend = 91154 (0x00016412)
[2016-05-04 09:19:47.328] [D] [zway] Job 0x13 (Nonce Report): success
[2016-05-04 09:19:47.329] [zway] Removing job: Nonce Report
[2016-05-04 09:19:47.340] [D] [zway] RECEIVED: ( 01 23 00 04 00 16 1D 98 81 96 8D 46 2B 3F 46 2A 7E 25 AF C5 0E EE FF E1 C6 AF 27 CF 6E 4F 41 D8 2C 8F FB 93 D2 )
[2016-05-04 09:19:47.341] [D] [zway] SENT ACK
[2016-05-04 09:19:47.342] [D] [zway] SETDATA devices.22.data.lastReceived = 0 (0x00000000)
[2016-05-04 09:19:47.343] [zway] Node 22:0 CC Security: Received a secure message
[2016-05-04 09:19:47.344] [D] [zway] SETDATA devices.22.instances.0.commandClasses.152.data.firstPart = **********
[2016-05-04 09:19:47.344] [zway] Node 22:0 CC Security: passing decrypted packet to application level: [ 71 05 00 00 00 ff 07 08 00 ]
[2016-05-04 09:19:47.346] [D] [zway] SETDATA devices.22.instances.0.commandClasses.113.data.7.eventParameters = byte[0]
[2016-05-04 09:19:47.346] [D] [zway] ( zero-length buffer )
[2016-05-04 09:19:47.347] [D] [zway] SETDATA devices.22.instances.0.commandClasses.113.data.7.event = 8 (0x00000008)
[2016-05-04 09:19:47.351] [D] [zway] SETDATA devices.22.instances.0.commandClasses.113.data.7.eventString = "Motion detected, location unknown"
[2016-05-04 09:19:47.352] [D] [zway] SETDATA devices.22.instances.0.commandClasses.113.data.7.status = 255 (0x000000ff)
[2016-05-04 09:19:47.353] [D] [zway] SETDATA devices.22.instances.0.commandClasses.113.data.7 = Empty
[2016-05-04 09:19:47.374] [D] [zway] RECEIVED: ( 01 23 00 04 00 16 1D 98 81 96 8D 46 2B 3F 46 2A 7E 25 AF C5 0E EE FF E1 C6 AF 27 CF 6E 4F 41 D8 2C 8F FB 93 D2 )
[2016-05-04 09:19:47.375] [D] [zway] SENT ACK
[2016-05-04 09:19:47.376] [D] [zway] SETDATA devices.22.data.lastReceived = 0 (0x00000000)
[2016-05-04 09:19:47.377] [zway] Node 22:0 CC Security: Received a secure message
[2016-05-04 09:19:47.378] [W] [zway] Node 22:0 CC Security: can not decrypt packet due to nonce lookup problem

So as you can see there is no OFF/ON events.

With v2.7, i got OFF/ON events:

[2016-05-04 09:22:11.061] [D] [zway] RECEIVED: ( 01 0D 00 04 00 14 07 56 01 30 03 FF D1 CB 64 )
[2016-05-04 09:22:11.061] [D] [zway] SENT ACK
[2016-05-04 09:22:11.062] [D] [zway] SETDATA devices.20.data.lastReceived = 0 (0x00000000)
[2016-05-04 09:22:11.062] [D] [zway] SETDATA devices.20.instances.0.commandClasses.48.data.1.level = True
[2016-05-04 09:22:11.062] [D] [zway] SETDATA devices.20.instances.0.commandClasses.48.data.1 = Empty
[2016-05-04 09:22:11.077] [D] [zway] RECEIVED: ( 01 0D 00 04 00 14 07 60 0D 01 01 20 01 FF 56 )
[2016-05-04 09:22:11.083] [D] [zway] SENT ACK
[2016-05-04 09:22:11.084] [D] [zway] SETDATA devices.20.data.lastReceived = 0 (0x00000000)
[2016-05-04 09:22:11.086] [D] [zway] SETDATA devices.1.instances.1.commandClasses.32.data.srcNodeId = 20 (0x00000014)
[2016-05-04 09:22:11.087] [D] [zway] SETDATA devices.1.instances.1.commandClasses.32.data.srcInstanceId = 1 (0x00000001)
[2016-05-04 09:22:11.088] [D] [zway] SETDATA devices.1.instances.1.commandClasses.32.data.level = 255 (0x000000ff)
[2016-05-04 09:22:11.133] [core] Notification: device-info (device-OnOff): {"dev":"Salon General purpose (20.0.48.1)","l":"on"}
[2016-05-04 09:22:11.407] [core] Notification: device-info (device-OnOff): {"dev":"Salon (20.1.1) Button","l":"on"}


Any clue is welcome !

Thanks in advance
regards

[zwavedistran]

i got also these trames correctly decrypted but still no OFF/ON event:

[2016-05-04 11:11:03.509] [D] [zway] RECEIVED: ( 01 08 00 04 00 19 02 98 40 30 )
[2016-05-04 11:11:03.511] [D] [zway] SENT ACK
[2016-05-04 11:11:03.512] [D] [zway] SETDATA devices.25.data.lastReceived = 0 (0x00000000)
[2016-05-04 11:11:03.514] [zway] Node 25:0 CC Security: sending Nonce Report
[2016-05-04 11:11:03.515] [zway] Adding job: Nonce Report
[2016-05-04 11:11:03.516] [D] [zway] SENDING (cb 0x65): ( 01 11 00 13 19 0A 98 80 D7 FD 79 FF 2B 01 8F 1D 05 65 82 )
[2016-05-04 11:11:03.520] [D] [zway] RECEIVED ACK
[2016-05-04 11:11:03.524] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2016-05-04 11:11:03.525] [D] [zway] SENT ACK
[2016-05-04 11:11:03.526] [D] [zway] Delivered to Z-Wave stack
[2016-05-04 11:11:03.540] [D] [zway] RECEIVED: ( 01 07 00 13 65 00 00 02 8C )
[2016-05-04 11:11:03.541] [D] [zway] SENT ACK
[2016-05-04 11:11:03.547] [zway] Job 0x13 (Nonce Report): Delivered
[2016-05-04 11:11:03.548] [D] [zway] SETDATA devices.25.data.lastPacketInfo.delivered = True
[2016-05-04 11:11:03.549] [D] [zway] SETDATA devices.25.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2016-05-04 11:11:03.550] [D] [zway] SETDATA devices.25.data.lastPacketInfo.deliveryTime = 20 (0x00000014)
[2016-05-04 11:11:03.550] [D] [zway] SETDATA devices.25.data.lastPacketInfo = **********
[2016-05-04 11:11:03.551] [D] [zway] SendData Response with callback 0x65 received: received by recipient
[2016-05-04 11:11:03.552] [D] [zway] SETDATA devices.25.data.lastSend = 136685 (0x000215ed)
[2016-05-04 11:11:03.553] [D] [zway] Job 0x13 (Nonce Report): success
[2016-05-04 11:11:03.554] [zway] Removing job: Nonce Report
[2016-05-04 11:11:03.566] [D] [zway] RECEIVED: ( 01 23 00 04 00 19 1D 98 81 C8 B9 0F 58 73 56 89 BA D1 E1 82 28 F7 1B A6 6A 71 36 D7 09 3B 52 BE 1C AE BD 58 56 )
[2016-05-04 11:11:03.567] [D] [zway] SENT ACK
[2016-05-04 11:11:03.568] [D] [zway] SETDATA devices.25.data.lastReceived = 0 (0x00000000)
[2016-05-04 11:11:03.574] [zway] Node 25:0 CC Security: Received a secure message
[2016-05-04 11:11:03.575] [D] [zway] SETDATA devices.25.instances.0.commandClasses.152.data.firstPart = **********
[2016-05-04 11:11:03.576] [zway] Node 25:0 CC Security: passing decrypted packet to application level: [ 71 05 00 00 00 ff 07 08 00 ]
[2016-05-04 11:11:03.580] [D] [zway] SETDATA devices.25.instances.0.commandClasses.113.data.7.eventParameters = byte[0]
[2016-05-04 11:11:03.583] [D] [zway] ( zero-length buffer )
[2016-05-04 11:11:03.584] [D] [zway] SETDATA devices.25.instances.0.commandClasses.113.data.7.event = 8 (0x00000008)
[2016-05-04 11:11:03.597] [D] [zway] SETDATA devices.25.instances.0.commandClasses.113.data.7.eventString = "Motion detected, location unknown"
[2016-05-04 11:11:03.598] [D] [zway] SETDATA devices.25.instances.0.commandClasses.113.data.7.status = 255 (0x000000ff)
[2016-05-04 11:11:03.599] [D] [zway] SETDATA devices.25.instances.0.commandClasses.113.data.7 = Empty

[zwavedistran]

[core] Notification: XXXXX <=== this trame is missing

[zwavedistran]

ok issue was about group association.

on v2.7 association are automated.

on v3.2, you have to go to expert, select your sensor; then go to association and add a new one related to "Motion".

that's it.