SwitchControlGenerator config not persistent after a reboot?

jacques · Post by **jacques** » 15 Mar 2015 22:17

Below you will find the sequence which fails in my configuration (PI + razberry + zway 2.0.0 ) :

In the automation modules User Interface (UI) I instanciate the "SwitchControlGenerator" module (Trap events from Remotes and Sensors)
Afterward I capture "on the fly" the four buttons of my keyfob (a zwave-me model) (this operation automaticaly registers 8 new devices in my UI (2 per button) : "ZWayVDev_zway_Remote_9-0-0-11", ZWayVDev_zway_Remote_9-0-0-12" ... until "ZWayVDev_zway_Remote_9-0-0-42")
Then I use these new generated devices (well the first two in my case) as "remote" conditions in 2 new automation rules to switch on/off a zwave device of my network.
At this step, all this stuff works fine : when I press the button of my keyfob, my device is switched accordingly.
BUT after a reboot of my PI (or a simple restart of the zway-server) the rules are no more activated
At this stage, if I save again the "SwitchControlGenerator" configuration in the UI (just hitting the save button, without changing anything else), it will start working again.

Any ideas ?

Herunder two extracts of my logs :

=> the fist one before a restart (where we can see the effective rules activations transmitted to device 11)

Code: Select all

[2015-03-15 20:08:11.090] [D] [zway] RECEIVED: ( 01 08 00 04 00 09 02 98 40 20 )
[2015-03-15 20:08:11.091] [D] [zway] SENT ACK
[2015-03-15 20:08:11.092] [D] [zway] SETDATA devices.9.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:11.094] [I] [zway] Node 9:0 CC Security: sending Nonce Report
[2015-03-15 20:08:11.096] [I] [zway] Adding job: Nonce Report
[2015-03-15 20:08:11.097] [D] [zway] SENDING (cb 0x0f): ( 01 11 00 13 09 0A 98 80 7B D1 33 14 FD 51 BE C7 05 0F B4 )
[2015-03-15 20:08:11.100] [D] [zway] RECEIVED ACK
[2015-03-15 20:08:11.104] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:08:11.105] [D] [zway] SENT ACK
[2015-03-15 20:08:11.107] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:08:12.065] [D] [zway] RECEIVED: ( 01 1E 00 04 00 09 18 98 81 80 9E BD 50 18 A4 D7 42 35 90 87 B5 AB 7B BD 3C BA 29 53 AE E0 C0 BF )
[2015-03-15 20:08:12.066] [D] [zway] SENT ACK
[2015-03-15 20:08:12.067] [D] [zway] SETDATA devices.9.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:12.069] [I] [zway] Node 9:0 CC Security: Received a secure message
[2015-03-15 20:08:12.070] [D] [zway] SETDATA devices.9.instances.0.commandClasses.152.data.firstPart = **********
[2015-03-15 20:08:12.071] [I] [zway] Node 9:0 CC Security: passing decrypted packet to application level: [ 2b 01 0b ff ]
[2015-03-15 20:08:12.072] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.srcNodeId = 9 (0x00000009)
[2015-03-15 20:08:12.074] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.srcInstanceId = 0 (0x00000000)
[2015-03-15 20:08:12.075] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.currentScene = 11 (0x0000000b)
[2015-03-15 20:08:12.076] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.dimmingDuration = 255 (0x000000ff)
[2015-03-15 20:08:12.078] [D] [zway] SETDATA devices.9.instances.0.commandClasses.43.data.currentScene = 11 (0x0000000b)
[2015-03-15 20:08:12.081] [D] [zway] SETDATA devices.9.instances.0.commandClasses.43.data.dimmingDuration = 255 (0x000000ff)
[2015-03-15 20:08:12.091] [I] [core] ---  LightScene_5 performCommand processing: {"0":"on"}
[2015-03-15 20:08:12.093] [I] [core] ---  Code_Device_toggleButton_4 performCommand processing: {"0":"on"}
[2015-03-15 20:08:12.096] [I] [zway] Adding job: Basic Set
[2015-03-15 20:08:12.098] [I] [zway] Adding job: Basic Get
[2015-03-15 20:08:12.099] [I] [core] ---  Code_Device_toggleButton_14 performCommand processing: {"0":"on"}
[2015-03-15 20:08:12.102] [I] [zway] Adding job: Basic Set
[2015-03-15 20:08:12.104] [I] [zway] Adding job: Basic Get
[2015-03-15 20:08:12.845] [D] [zway] RECEIVED: ( 01 07 00 13 0F 01 00 AE 4B )
[2015-03-15 20:08:12.847] [D] [zway] SENT ACK
[2015-03-15 20:08:12.848] [I] [zway] Job 0x13 (Nonce Report): Not delivered to recipient
[2015-03-15 20:08:12.849] [D] [zway] SETDATA devices.9.data.lastPacketInfo.delivered = False
[2015-03-15 20:08:12.850] [D] [zway] SETDATA devices.9.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2015-03-15 20:08:12.851] [D] [zway] SETDATA devices.9.data.lastPacketInfo.deliveryTime = 1741 (0x000006cd)
[2015-03-15 20:08:12.853] [D] [zway] SETDATA devices.9.data.lastPacketInfo = **********
[2015-03-15 20:08:12.855] [D] [zway] SETDATA devices.9.data.isAwake = False
[2015-03-15 20:08:12.856] [D] [zway] Sending the queue for node 9 into sleep
[2015-03-15 20:08:12.857] [I] [zway] Job 0x13 (Nonce Report): Cancelling job: Nonce Report
[2015-03-15 20:08:12.858] [I] [zway] Removing job: Nonce Report
[2015-03-15 20:08:12.859] [D] [zway] SENDING (cb 0x10): ( 01 0A 00 13 02 03 20 01 FF 25 10 0C )
[2015-03-15 20:08:12.862] [D] [zway] RECEIVED ACK
[2015-03-15 20:08:12.866] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:08:12.867] [D] [zway] SENT ACK
[2015-03-15 20:08:12.869] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:08:12.882] [D] [zway] RECEIVED: ( 01 07 00 13 10 00 00 02 F9 )
[2015-03-15 20:08:12.883] [D] [zway] SENT ACK
[2015-03-15 20:08:12.884] [I] [zway] Job 0x13 (Basic Set): Delivered
[2015-03-15 20:08:12.886] [D] [zway] SETDATA devices.2.data.lastPacketInfo.delivered = True
[2015-03-15 20:08:12.887] [D] [zway] SETDATA devices.2.data.lastPacketInfo.packetLength = 6 (0x00000006)
[2015-03-15 20:08:12.889] [D] [zway] SETDATA devices.2.data.lastPacketInfo.deliveryTime = 16 (0x00000010)
[2015-03-15 20:08:12.890] [D] [zway] SETDATA devices.2.data.lastPacketInfo = **********
[2015-03-15 20:08:12.891] [D] [zway] SendData Response with callback 0x10 received: received by recipient
[2015-03-15 20:08:12.892] [D] [zway] SETDATA devices.2.data.lastSend = 383221 (0x0005d8f5)
[2015-03-15 20:08:12.893] [D] [zway] Job 0x13 (Basic Set): success
[2015-03-15 20:08:12.894] [I] [zway] Removing job: Basic Set
[2015-03-15 20:08:12.896] [D] [zway] SENDING (cb 0x11): ( 01 0A 00 13 0B 03 20 01 FF 25 11 04 )
[2015-03-15 20:08:12.899] [D] [zway] RECEIVED ACK
[2015-03-15 20:08:12.903] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:08:12.905] [D] [zway] SENT ACK
[2015-03-15 20:08:12.906] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:08:12.939] [D] [zway] RECEIVED: ( 01 09 00 04 00 02 03 26 03 63 B5 )
[2015-03-15 20:08:12.941] [D] [zway] SENT ACK
[2015-03-15 20:08:12.942] [D] [zway] SETDATA devices.2.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:12.943] [D] [zway] SETDATA devices.2.instances.0.commandClasses.38.data.level = 99 (0x00000063)
[2015-03-15 20:08:12.956] [D] [zway] RECEIVED: ( 01 07 00 13 11 00 00 06 FC )
[2015-03-15 20:08:12.957] [D] [zway] SENT ACK
[2015-03-15 20:08:12.959] [I] [zway] Job 0x13 (Basic Set): Delivered
[2015-03-15 20:08:12.960] [D] [zway] SETDATA devices.11.data.lastPacketInfo.delivered = True
[2015-03-15 20:08:12.965] [D] [zway] SETDATA devices.11.data.lastPacketInfo.packetLength = 6 (0x00000006)
[2015-03-15 20:08:12.966] [D] [zway] SETDATA devices.11.data.lastPacketInfo.deliveryTime = 52 (0x00000034)
[2015-03-15 20:08:12.968] [D] [zway] SETDATA devices.11.data.lastPacketInfo = **********
[2015-03-15 20:08:12.969] [D] [zway] SendData Response with callback 0x11 received: received by recipient
[2015-03-15 20:08:12.970] [D] [zway] SETDATA devices.11.data.lastSend = 383226 (0x0005d8fa)
[2015-03-15 20:08:12.972] [D] [zway] Job 0x13 (Basic Set): success
[2015-03-15 20:08:12.973] [I] [zway] Removing job: Basic Set
[2015-03-15 20:08:12.985] [D] [zway] SENDING (cb 0x12): ( 01 09 00 13 02 02 20 02 25 12 F0 )
[2015-03-15 20:08:12.987] [D] [zway] RECEIVED ACK
[2015-03-15 20:08:12.991] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:08:12.992] [D] [zway] SENT ACK
[2015-03-15 20:08:12.995] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:08:13.000] [D] [zway] RECEIVED: ( 01 09 00 04 00 0B 03 26 03 63 BC )
[2015-03-15 20:08:13.001] [D] [zway] SENT ACK
[2015-03-15 20:08:13.003] [D] [zway] SETDATA devices.11.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:13.004] [D] [zway] SETDATA devices.11.instances.0.commandClasses.38.data.level = 99 (0x00000063)
[2015-03-15 20:08:13.016] [D] [zway] RECEIVED: ( 01 07 00 13 12 00 00 03 FA )
[2015-03-15 20:08:13.017] [D] [zway] SENT ACK
[2015-03-15 20:08:13.018] [I] [zway] Job 0x13 (Basic Get): Delivered
[2015-03-15 20:08:13.019] [D] [zway] SETDATA devices.2.data.lastPacketInfo.delivered = True
[2015-03-15 20:08:13.020] [D] [zway] SETDATA devices.2.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2015-03-15 20:08:13.022] [D] [zway] SETDATA devices.2.data.lastPacketInfo.deliveryTime = 23 (0x00000017)
[2015-03-15 20:08:13.023] [D] [zway] SETDATA devices.2.data.lastPacketInfo = **********
[2015-03-15 20:08:13.026] [D] [zway] SendData Response with callback 0x12 received: received by recipient
[2015-03-15 20:08:13.028] [D] [zway] SETDATA devices.2.data.lastSend = 383229 (0x0005d8fd)
[2015-03-15 20:08:13.029] [D] [zway] Job 0x13 (Basic Get): success
[2015-03-15 20:08:13.030] [I] [zway] Removing job: Basic Get
[2015-03-15 20:08:13.048] [D] [zway] RECEIVED: ( 01 09 00 04 00 02 03 20 03 63 B3 )
[2015-03-15 20:08:13.049] [D] [zway] SENT ACK
[2015-03-15 20:08:13.050] [D] [zway] SETDATA devices.2.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:13.051] [D] [zway] SETDATA devices.2.instances.0.commandClasses.32.data.level = 99 (0x00000063)
[2015-03-15 20:08:13.052] [D] [zway] SETDATA devices.2.instances.0.commandClasses.38.data.level = 99 (0x00000063)
[2015-03-15 20:08:13.075] [D] [zway] SENDING (cb 0x13): ( 01 09 00 13 0B 02 20 02 25 13 F8 )
[2015-03-15 20:08:13.078] [D] [zway] RECEIVED ACK
[2015-03-15 20:08:13.083] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:08:13.084] [D] [zway] SENT ACK
[2015-03-15 20:08:13.086] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:08:13.134] [D] [zway] RECEIVED: ( 01 07 00 13 13 00 00 06 FE )
[2015-03-15 20:08:13.135] [D] [zway] SENT ACK
[2015-03-15 20:08:13.136] [I] [zway] Job 0x13 (Basic Get): Delivered
[2015-03-15 20:08:13.138] [D] [zway] SETDATA devices.11.data.lastPacketInfo.delivered = True
[2015-03-15 20:08:13.139] [D] [zway] SETDATA devices.11.data.lastPacketInfo.packetLength = 5 (0x00000005)
[2015-03-15 20:08:13.140] [D] [zway] SETDATA devices.11.data.lastPacketInfo.deliveryTime = 51 (0x00000033)
[2015-03-15 20:08:13.142] [D] [zway] SETDATA devices.11.data.lastPacketInfo = **********
[2015-03-15 20:08:13.143] [D] [zway] SendData Response with callback 0x13 received: received by recipient
[2015-03-15 20:08:13.144] [D] [zway] SETDATA devices.11.data.lastSend = 383237 (0x0005d905)
[2015-03-15 20:08:13.154] [D] [zway] Job 0x13 (Basic Get): success
[2015-03-15 20:08:13.155] [I] [zway] Removing job: Basic Get
[2015-03-15 20:08:13.178] [D] [zway] RECEIVED: ( 01 09 00 04 00 0B 03 20 03 63 BA )
[2015-03-15 20:08:13.180] [D] [zway] SENT ACK
[2015-03-15 20:08:13.181] [D] [zway] SETDATA devices.11.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:08:13.182] [D] [zway] SETDATA devices.11.instances.0.commandClasses.32.data.level = 99 (0x00000063)
[2015-03-15 20:08:13.183] [D] [zway] SETDATA devices.11.instances.0.commandClasses.38.data.level = 99 (0x00000063)
[2015-03-15 20:08:33.037] [D] [zway] Job 0x13: deleted from queue

=> the second one after a restart (in that case the rules are not fired anymore - device 9 is the keyfob)

Code: Select all

[2015-03-15 20:01:36.951] [D] [zway] RECEIVED: ( 01 08 00 04 00 09 02 98 40 20 )
[2015-03-15 20:01:36.952] [D] [zway] SENT ACK
[2015-03-15 20:01:36.953] [D] [zway] SETDATA devices.9.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:01:36.955] [I] [zway] Node 9:0 CC Security: sending Nonce Report
[2015-03-15 20:01:36.956] [I] [zway] Adding job: Nonce Report
[2015-03-15 20:01:36.957] [D] [zway] SENDING (cb 0x03): ( 01 11 00 13 09 0A 98 80 9B B5 05 97 14 5F 3F 93 05 03 BB )
[2015-03-15 20:01:36.960] [D] [zway] RECEIVED ACK
[2015-03-15 20:01:36.966] [D] [zway] RECEIVED: ( 01 04 01 13 01 E8 )
[2015-03-15 20:01:36.967] [D] [zway] SENT ACK
[2015-03-15 20:01:36.968] [D] [zway] Delivered to Z-Wave stack
[2015-03-15 20:01:36.993] [D] [zway] RECEIVED: ( 01 07 00 13 03 00 00 04 EC )
[2015-03-15 20:01:36.995] [D] [zway] SENT ACK
[2015-03-15 20:01:36.996] [I] [zway] Job 0x13 (Nonce Report): Delivered
[2015-03-15 20:01:36.997] [D] [zway] SETDATA devices.9.data.lastPacketInfo.delivered = True
[2015-03-15 20:01:36.998] [D] [zway] SETDATA devices.9.data.lastPacketInfo.packetLength = 13 (0x0000000d)
[2015-03-15 20:01:36.999] [D] [zway] SETDATA devices.9.data.lastPacketInfo.deliveryTime = 27 (0x0000001b)
[2015-03-15 20:01:37.001] [D] [zway] SETDATA devices.9.data.lastPacketInfo = **********
[2015-03-15 20:01:37.002] [D] [zway] SendData Response with callback 0x03 received: received by recipient
[2015-03-15 20:01:37.003] [D] [zway] SETDATA devices.9.data.lastSend = 344554 (0x000541ea)
[2015-03-15 20:01:37.005] [D] [zway] Job 0x13 (Nonce Report): success
[2015-03-15 20:01:37.006] [I] [zway] Removing job: Nonce Report
[2015-03-15 20:01:37.054] [D] [zway] RECEIVED: ( 01 1E 00 04 00 09 18 98 81 BC 04 36 BB 77 FB 82 AE F1 FF 0F 30 91 9B 94 8C D0 C4 57 C5 E3 5B 65 )
[2015-03-15 20:01:37.055] [D] [zway] SENT ACK
[2015-03-15 20:01:37.057] [D] [zway] SETDATA devices.9.data.lastReceived = 0 (0x00000000)
[2015-03-15 20:01:37.058] [I] [zway] Node 9:0 CC Security: Received a secure message
[2015-03-15 20:01:37.059] [D] [zway] SETDATA devices.9.instances.0.commandClasses.152.data.firstPart = **********
[2015-03-15 20:01:37.061] [I] [zway] Node 9:0 CC Security: passing decrypted packet to application level: [ 2b 01 0b ff ]
[2015-03-15 20:01:37.062] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.srcNodeId = 9 (0x00000009)
[2015-03-15 20:01:37.063] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.srcInstanceId = 0 (0x00000000)
[2015-03-15 20:01:37.065] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.currentScene = 11 (0x0000000b)
[2015-03-15 20:01:37.066] [D] [zway] SETDATA devices.1.instances.0.commandClasses.43.data.dimmingDuration = 255 (0x000000ff)
[2015-03-15 20:01:37.067] [D] [zway] SETDATA devices.9.instances.0.commandClasses.43.data.currentScene = 11 (0x0000000b)
[2015-03-15 20:01:37.068] [D] [zway] SETDATA devices.9.instances.0.commandClasses.43.data.dimmingDuration = 255 (0x000000ff)