Z-Wave-Me / z-way-issues

This repo is only to host issues for Z-Way.
6 stars 1 forks source link

MULTI_CHANNEL_ASSOCIATION_SET not working #103

Closed bogri closed 8 years ago

bogri commented 8 years ago

Trying to set MULTI_CHANNEL_ASSOCIATION_SET according to

/JS/Run/zway.devices[10].MultiChannelAssociation.Set(3,1,1) GroupId = 3, AssocNodeId = 1, AssocInstanceId = 1

but the value is never set. Going to Expert UI -> Configuration -> Interview -> Command Class -> MultiChannelAssociation shows:

3: None (21:19) max: 16 (21:19) nodesInstances: (21:19)

Log when setting the value: [2016-03-23 21:40:56.937] [I] [zway] Adding job: MultiChannelAssociation Set [2016-03-23 21:40:56.938] [I] [zway] Adding job: Assign return route [2016-03-23 21:40:56.938] [I] [zway] Adding job: MultiChannelAssociation Get [2016-03-23 21:40:56.941] [D] [zway] SENDING (cb 0x3d): ( 01 0D 00 13 0A 06 8E 01 03 00 01 01 25 3D 79 ) [2016-03-23 21:40:56.943] [D] [zway] RECEIVED ACK [2016-03-23 21:40:56.948] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 ) [2016-03-23 21:40:56.948] [D] [zway] SENT ACK [2016-03-23 21:40:56.949] [D] [zway] Delivered to Z-Wave stack [2016-03-23 21:40:56.971] [D] [zway] RECEIVED: ( 01 07 00 13 3D 00 00 02 D4 ) [2016-03-23 21:40:56.971] [D] [zway] SENT ACK [2016-03-23 21:40:56.972] [I] [zway] Job 0x13 (MultiChannelAssociation Set): Delivered [2016-03-23 21:40:56.972] [D] [zway] SETDATA devices.10.data.lastPacketInfo.delivered = True [2016-03-23 21:40:56.973] [D] [zway] SETDATA devices.10.data.lastPacketInfo.packetLength = 9 (0x00000009) [2016-03-23 21:40:56.973] [D] [zway] SETDATA devices.10.data.lastPacketInfo.deliveryTime = 23 (0x00000017) [2016-03-23 21:40:56.974] [D] [zway] SETDATA devices.10.data.lastPacketInfo = ** [2016-03-23 21:40:56.974] [D] [zway] SendData Response with callback 0x3d received: received by recipient [2016-03-23 21:40:56.974] [D] [zway] SETDATA devices.10.data.lastSend = 156850623 (0x095959bf) [2016-03-23 21:40:56.975] [D] [zway] Job 0x13 (MultiChannelAssociation Set): success [2016-03-23 21:40:56.975] [I] [zway] Removing job: MultiChannelAssociation Set [2016-03-23 21:40:57.042] [D] [zway] SENDING (cb 0x3e): ( 01 06 00 46 0A 01 3E 8A ) [2016-03-23 21:40:57.044] [D] [zway] RECEIVED ACK [2016-03-23 21:40:57.051] [D] [zway] RECEIVED: ( 01 04 01 46 01 BD ) [2016-03-23 21:40:57.051] [D] [zway] SENT ACK [2016-03-23 21:40:57.051] [D] [zway] Delivered to Z-Wave stack: process started [2016-03-23 21:40:57.392] [D] [zway] RECEIVED: ( 01 05 00 46 3E 00 82 ) [2016-03-23 21:40:57.392] [D] [zway] SENT ACK [2016-03-23 21:40:57.392] [D] [zway] AssignReturnRoute Response with callback 0x3e received: received by recipient [2016-03-23 21:40:57.392] [D] [zway] Job 0x46 (Assign return route): success [2016-03-23 21:40:57.392] [I] [zway] Removing job: Assign return route [2016-03-23 21:40:57.392] [D] [zway] SENDING (cb 0x3f): ( 01 0A 00 13 0A 03 8E 02 03 25 3F 7A ) [2016-03-23 21:40:57.399] [D] [zway] RECEIVED ACK [2016-03-23 21:40:57.399] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 ) [2016-03-23 21:40:57.399] [D] [zway] SENT ACK [2016-03-23 21:40:57.399] [D] [zway] Delivered to Z-Wave stack [2016-03-23 21:40:57.419] [D] [zway] RECEIVED: ( 01 07 00 13 3F 00 00 02 D6 ) [2016-03-23 21:40:57.419] [D] [zway] SENT ACK [2016-03-23 21:40:57.420] [I] [zway] Job 0x13 (MultiChannelAssociation Get): Delivered [2016-03-23 21:40:57.420] [D] [zway] SETDATA devices.10.data.lastPacketInfo.delivered = True [2016-03-23 21:40:57.420] [D] [zway] SETDATA devices.10.data.lastPacketInfo.packetLength = 6 (0x00000006) [2016-03-23 21:40:57.420] [D] [zway] SETDATA devices.10.data.lastPacketInfo.deliveryTime = 20 (0x00000014) [2016-03-23 21:40:57.420] [D] [zway] SETDATA devices.10.data.lastPacketInfo = ** [2016-03-23 21:40:57.420] [D] [zway] SendData Response with callback 0x3f received: received by recipient [2016-03-23 21:40:57.420] [D] [zway] SETDATA devices.10.data.lastSend = 156850667 (0x095959eb) [2016-03-23 21:40:57.421] [D] [zway] Job 0x13 (MultiChannelAssociation Get): success [2016-03-23 21:40:57.421] [I] [zway] Removing job: MultiChannelAssociation Get [2016-03-23 21:40:57.429] [D] [zway] RECEIVED: ( 01 0B 00 04 00 0A 05 8E 03 03 10 00 61 ) [2016-03-23 21:40:57.429] [D] [zway] SENT ACK [2016-03-23 21:40:57.429] [D] [zway] SETDATA devices.10.data.lastReceived = 0 (0x00000000) [2016-03-23 21:40:57.430] [I] [zway] Node 10:0 CC MultiChannelAssociation: Group 3 report [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.max = 16 (0x00000010) [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.133.data.3.nodes = byte[0] [2016-03-23 21:40:57.430] [D] [zway](zero-length buffer) [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.nodesInstances = byte[0] [2016-03-23 21:40:57.430] [D] [zway](zero-length buffer) [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.133.data.3.nodesToFollow = ** [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.nodesInstancesToFollow = ** [2016-03-23 21:40:57.430] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3 = Empty

Setting the same by using the tab Expert Commands in Expert UI according to Instance: 0 Command Class: MultiChannelAssociation Command/Parameter: Group: 3 Node: Z-Way instance: 1

shows the following in the log:

[2016-03-23 21:43:40.046] [I] [zway] Adding job: MultiChannelAssociation Set [2016-03-23 21:43:40.047] [I] [zway] Adding job: Assign return route [2016-03-23 21:43:40.047] [I] [zway] Adding job: MultiChannelAssociation Get [2016-03-23 21:43:40.050] [D] [zway] SENDING (cb 0x41): ( 01 0D 00 13 0A 06 8E 01 03 00 01 01 25 41 05 ) [2016-03-23 21:43:40.052] [D] [zway] RECEIVED ACK [2016-03-23 21:43:40.056] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 ) [2016-03-23 21:43:40.056] [D] [zway] SENT ACK [2016-03-23 21:43:40.056] [D] [zway] Delivered to Z-Wave stack [2016-03-23 21:43:40.080] [D] [zway] RECEIVED: ( 01 07 00 13 41 00 00 02 A8 ) [2016-03-23 21:43:40.080] [D] [zway] SENT ACK [2016-03-23 21:43:40.081] [I] [zway] Job 0x13 (MultiChannelAssociation Set): Delivered [2016-03-23 21:43:40.081] [D] [zway] SETDATA devices.10.data.lastPacketInfo.delivered = True [2016-03-23 21:43:40.081] [D] [zway] SETDATA devices.10.data.lastPacketInfo.packetLength = 9 (0x00000009) [2016-03-23 21:43:40.081] [D] [zway] SETDATA devices.10.data.lastPacketInfo.deliveryTime = 24 (0x00000018) [2016-03-23 21:43:40.081] [D] [zway] SETDATA devices.10.data.lastPacketInfo = ** [2016-03-23 21:43:40.081] [D] [zway] SendData Response with callback 0x41 received: received by recipient [2016-03-23 21:43:40.081] [D] [zway] SETDATA devices.10.data.lastSend = 156866687 (0x0959987f) [2016-03-23 21:43:40.082] [D] [zway] Job 0x13 (MultiChannelAssociation Set): success [2016-03-23 21:43:40.082] [I] [zway] Removing job: MultiChannelAssociation Set [2016-03-23 21:43:40.151] [D] [zway] SENDING (cb 0x42): ( 01 06 00 46 0A 01 42 F6 ) [2016-03-23 21:43:40.153] [D] [zway] RECEIVED ACK [2016-03-23 21:43:40.160] [D] [zway] RECEIVED: ( 01 04 01 46 01 BD ) [2016-03-23 21:43:40.160] [D] [zway] SENT ACK [2016-03-23 21:43:40.160] [D] [zway] Delivered to Z-Wave stack: process started [2016-03-23 21:43:40.502] [D] [zway] RECEIVED: ( 01 05 00 46 42 00 FE ) [2016-03-23 21:43:40.502] [D] [zway] SENT ACK [2016-03-23 21:43:40.502] [D] [zway] AssignReturnRoute Response with callback 0x42 received: received by recipient [2016-03-23 21:43:40.502] [D] [zway] Job 0x46 (Assign return route): success [2016-03-23 21:43:40.502] [I] [zway] Removing job: Assign return route [2016-03-23 21:43:40.503] [D] [zway] SENDING (cb 0x43): ( 01 0A 00 13 0A 03 8E 02 03 25 43 06 ) [2016-03-23 21:43:40.506] [D] [zway] RECEIVED ACK [2016-03-23 21:43:40.509] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 ) [2016-03-23 21:43:40.509] [D] [zway] SENT ACK [2016-03-23 21:43:40.509] [D] [zway] Delivered to Z-Wave stack [2016-03-23 21:43:40.526] [D] [zway] RECEIVED: ( 01 07 00 13 43 00 00 02 AA ) [2016-03-23 21:43:40.527] [D] [zway] SENT ACK [2016-03-23 21:43:40.527] [I] [zway] Job 0x13 (MultiChannelAssociation Get): Delivered [2016-03-23 21:43:40.527] [D] [zway] SETDATA devices.10.data.lastPacketInfo.delivered = True [2016-03-23 21:43:40.527] [D] [zway] SETDATA devices.10.data.lastPacketInfo.packetLength = 6 (0x00000006) [2016-03-23 21:43:40.527] [D] [zway] SETDATA devices.10.data.lastPacketInfo.deliveryTime = 17 (0x00000011) [2016-03-23 21:43:40.527] [D] [zway] SETDATA devices.10.data.lastPacketInfo = ** [2016-03-23 21:43:40.528] [D] [zway] SendData Response with callback 0x43 received: received by recipient [2016-03-23 21:43:40.528] [D] [zway] SETDATA devices.10.data.lastSend = 156866731 (0x095998ab) [2016-03-23 21:43:40.528] [D] [zway] Job 0x13 (MultiChannelAssociation Get): success [2016-03-23 21:43:40.528] [I] [zway] Removing job: MultiChannelAssociation Get [2016-03-23 21:43:40.536] [D] [zway] RECEIVED: ( 01 0B 00 04 00 0A 05 8E 03 03 10 00 61 ) [2016-03-23 21:43:40.536] [D] [zway] SENT ACK [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.data.lastReceived = 0 (0x00000000) [2016-03-23 21:43:40.537] [I] [zway] Node 10:0 CC MultiChannelAssociation: Group 3 report [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.max = 16 (0x00000010) [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.133.data.3.nodes = byte[0] [2016-03-23 21:43:40.537] [D] [zway](zero-length buffer) [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.nodesInstances = byte[0] [2016-03-23 21:43:40.537] [D] [zway](zero-length buffer) [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.133.data.3.nodesToFollow = ** [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.nodesInstancesToFollow = ** [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3 = Empty

Device: Qubino Flush 2 relay (ZMNHBD1) Z-Way: v2.2.1 Razberry

PoltoS commented 8 years ago

Z-Way handled the job correctly - correct packet delivered, correct handling of answer. The problem is clearly on the device's side. Please contact Qubino showing this log

bogri commented 8 years ago

I'm still having issues with this, but reading the log

[2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3 = Empty [2016-03-23 21:43:40.537] [D] [zway] SETDATA devices.10.instances.0.commandClasses.142.data.3.nodesInstances = byte[0]

seems like the controller tries to set the correct data (device = 10, MultichannelAssoc = 142, Group = 3), but it's setting it to "Empty", and notesInstances is empty as well, or am I interpreting the log wrongly? Doesn't the log print the actual value the controller tries to set in the device?

Can this be reopened in some way?