z-way-server instable?

Discussions about RaZberry - Z-Wave board for Raspberry computer
Post Reply
Tiptop
Posts: 56
Joined: 01 Mar 2013 13:50

z-way-server instable?

Post by Tiptop »

Hello,

I am currently playing around with the RaZberry system to setup my home automation plans.
From time to time, the z-way-server crashes and I need to reboot the RPi to get it reachable through the port 8083, again.
I have also started the z-way-server manually and already have seen that the z-way-server terminates abnormally in some rare cases.

I think this is a big problem when using the RaZberry as main Z-Wave server... at least the server should be installed in a way where it gets restarted automatically, after a crash.

Is this a known issue or can I help you some way to find the reason for the crashes?

Thanks in advance!

Regards,
Stefan

PS: It seems that the crashes happen more frequently when using the "Update routes" functionality a bit too often...
User avatar
PoltoS
Posts: 7565
Joined: 26 Jan 2011 19:36

We have not seen this yet,

Post by PoltoS »

We have not seen this yet, but some bugs were fixed recently. First of all please update the software (run the same install script using wget as you did previously) and try it.

If you still experience the problem, please provide us with logs (at least last 200 lines) and a coredump (to generate it use "ulimit -c unlimited" before running z-way-server manually).

Our goal is to make RaZberry/Z-Way 100% stable.
Tiptop
Posts: 56
Joined: 01 Mar 2013 13:50

Still crashing/exiting...

Post by Tiptop »

Bad news:
Even with today's release, I can reproduce crashes if I stress the system by calling Update Routes, Request NIF from all devices and perform a HTML page reload... the crashes are not easily reproducable, so I guess there is an internal race condition between threads, somewhere.
I even once got a core dump, but I was not sure how I achieved this. I will send you one as soon as I got one, again.
In the latest stress condition, z-way-server ist silently stopped, no core dump, no error message at all.
I run z-way-server directly. Here is the last part of the debug output:

[2013-03-04 12:24:08.966] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:24:08.968] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396248 (0x51348458)
[2013-03-04 12:24:08.969] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:24:08.970] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:24:08.971] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:24:08.972] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:24:08.973] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:24:08.974] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:24:08.975] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:24:08.976] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:24:08.977] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:24:08.978] Trying to create command for unknown CC 0x46
[2013-03-04 12:24:08.979] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:24:08.980] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:24:08.981] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396248 (0x51348458)
[2013-03-04 12:24:08.982] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:24:08.984] Running wakeup handler for node 8
[2013-03-04 12:24:08.984] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396248 (0x51348458)
[2013-03-04 12:24:08.986] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:24:08.986] Adding job: Wakeup Sleep
[2013-03-04 12:24:08.987] SENDING (cb 0x01): ( 01 09 00 13 08 02 84 08 05 01 67 )
[2013-03-04 12:24:09.000] RECEIVED ACK
[2013-03-04 12:24:09.011] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:24:09.012] SENT ACK
[2013-03-04 12:24:09.014] Delivered to Z-Wave stack
[2013-03-04 12:24:09.025] RECEIVED: ( 01 05 00 13 01 00 E8 )
[2013-03-04 12:24:09.027] SENT ACK
[2013-03-04 12:24:09.027] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:24:09.028] SendData Response with callback 0x01 received: received by recipient
[2013-03-04 12:24:09.029] SETDATA devices.8.data.lastSend = 119832 (0x0001d418)
[2013-03-04 12:24:09.030] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:24:09.031] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:24:09.032] Sending the queue for node 8 into sleep
[2013-03-04 12:24:09.033] Removing job: Wakeup Sleep
[2013-03-04 12:24:27.918] Job 0x13: deleted from queue
[2013-03-04 12:24:34.583] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:24:34.593] SENT ACK
[2013-03-04 12:24:34.595] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:24:34.596] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396274 (0x51348472)
[2013-03-04 12:24:34.597] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:24:34.598] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:24:34.599] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:24:34.599] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:24:34.601] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:24:34.601] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:24:34.602] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:24:34.604] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:24:34.605] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:24:34.605] Trying to create command for unknown CC 0x46
[2013-03-04 12:24:34.606] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:24:34.607] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:24:34.607] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396274 (0x51348472)
[2013-03-04 12:24:34.608] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:24:34.609] Running wakeup handler for node 8
[2013-03-04 12:24:34.610] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396274 (0x51348472)
[2013-03-04 12:24:34.611] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:24:34.613] Adding job: Wakeup Sleep
[2013-03-04 12:24:34.625] SENDING (cb 0x02): ( 01 09 00 13 08 02 84 08 05 02 64 )
[2013-03-04 12:24:34.638] RECEIVED ACK
[2013-03-04 12:24:34.649] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:24:34.651] SENT ACK
[2013-03-04 12:24:34.653] Delivered to Z-Wave stack
[2013-03-04 12:24:34.664] RECEIVED: ( 01 05 00 13 02 00 EB )
[2013-03-04 12:24:34.665] SENT ACK
[2013-03-04 12:24:34.666] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:24:34.667] SendData Response with callback 0x02 received: received by recipient
[2013-03-04 12:24:34.667] SETDATA devices.8.data.lastSend = 122104 (0x0001dcf8)
[2013-03-04 12:24:34.668] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:24:34.669] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:24:34.670] Sending the queue for node 8 into sleep
[2013-03-04 12:24:34.671] Removing job: Wakeup Sleep
[2013-03-04 12:24:53.551] Job 0x13: deleted from queue
[2013-03-04 12:25:00.213] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:25:00.223] SENT ACK
[2013-03-04 12:25:00.224] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:25:00.225] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396300 (0x5134848c)
[2013-03-04 12:25:00.226] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:25:00.227] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:25:00.228] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:25:00.229] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:25:00.230] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:25:00.231] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:25:00.232] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:25:00.233] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:25:00.234] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:25:00.235] Trying to create command for unknown CC 0x46
[2013-03-04 12:25:00.236] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:25:00.237] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:25:00.237] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396300 (0x5134848c)
[2013-03-04 12:25:00.238] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:25:00.239] Running wakeup handler for node 8
[2013-03-04 12:25:00.240] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396300 (0x5134848c)
[2013-03-04 12:25:00.241] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:25:00.242] Adding job: Wakeup Sleep
[2013-03-04 12:25:00.244] SENDING (cb 0x03): ( 01 09 00 13 08 02 84 08 05 03 65 )
[2013-03-04 12:25:00.258] RECEIVED ACK
[2013-03-04 12:25:00.269] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:25:00.271] SENT ACK
[2013-03-04 12:25:00.272] Delivered to Z-Wave stack
[2013-03-04 12:25:00.283] RECEIVED: ( 01 05 00 13 03 00 EA )
[2013-03-04 12:25:00.285] SENT ACK
[2013-03-04 12:25:00.288] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:25:00.288] SendData Response with callback 0x03 received: received by recipient
[2013-03-04 12:25:00.289] SETDATA devices.8.data.lastSend = 124375 (0x0001e5d7)
[2013-03-04 12:25:00.290] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:25:00.291] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:25:00.292] Sending the queue for node 8 into sleep
[2013-03-04 12:25:00.294] Removing job: Wakeup Sleep
[2013-03-04 12:25:19.163] Job 0x13: deleted from queue
[2013-03-04 12:25:25.838] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:25:25.848] SENT ACK
[2013-03-04 12:25:25.849] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:25:25.850] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396325 (0x513484a5)
[2013-03-04 12:25:25.851] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:25:25.852] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:25:25.853] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:25:25.854] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:25:25.855] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:25:25.857] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:25:25.858] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:25:25.859] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:25:25.861] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:25:25.861] Trying to create command for unknown CC 0x46
[2013-03-04 12:25:25.862] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:25:25.863] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:25:25.864] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396325 (0x513484a5)
[2013-03-04 12:25:25.865] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:25:25.866] Running wakeup handler for node 8
[2013-03-04 12:25:25.867] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396325 (0x513484a5)
[2013-03-04 12:25:25.869] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:25:25.870] Adding job: Wakeup Sleep
[2013-03-04 12:25:25.871] SENDING (cb 0x04): ( 01 09 00 13 08 02 84 08 05 04 62 )
[2013-03-04 12:25:25.885] RECEIVED ACK
[2013-03-04 12:25:25.897] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:25:25.899] SENT ACK
[2013-03-04 12:25:25.900] Delivered to Z-Wave stack
[2013-03-04 12:25:25.911] RECEIVED: ( 01 05 00 13 04 00 ED )
[2013-03-04 12:25:25.913] SENT ACK
[2013-03-04 12:25:25.914] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:25:25.915] SendData Response with callback 0x04 received: received by recipient
[2013-03-04 12:25:25.916] SETDATA devices.8.data.lastSend = 126647 (0x0001eeb7)
[2013-03-04 12:25:25.917] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:25:25.918] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:25:25.919] Sending the queue for node 8 into sleep
[2013-03-04 12:25:25.921] Removing job: Wakeup Sleep
[2013-03-04 12:25:44.796] Job 0x13: deleted from queue
[2013-03-04 12:25:51.461] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:25:51.471] SENT ACK
[2013-03-04 12:25:51.472] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:25:51.473] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396351 (0x513484bf)
[2013-03-04 12:25:51.474] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:25:51.475] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:25:51.475] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:25:51.476] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:25:51.477] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:25:51.478] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:25:51.479] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:25:51.480] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:25:51.480] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:25:51.481] Trying to create command for unknown CC 0x46
[2013-03-04 12:25:51.482] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:25:51.483] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:25:51.484] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396351 (0x513484bf)
[2013-03-04 12:25:51.484] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:25:51.485] Running wakeup handler for node 8
[2013-03-04 12:25:51.486] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396351 (0x513484bf)
[2013-03-04 12:25:51.487] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:25:51.489] Adding job: Wakeup Sleep
[2013-03-04 12:25:51.501] SENDING (cb 0x05): ( 01 09 00 13 08 02 84 08 05 05 63 )
[2013-03-04 12:25:51.514] RECEIVED ACK
[2013-03-04 12:25:51.525] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:25:51.526] SENT ACK
[2013-03-04 12:25:51.527] Delivered to Z-Wave stack
[2013-03-04 12:25:51.538] RECEIVED: ( 01 05 00 13 05 00 EC )
[2013-03-04 12:25:51.541] SENT ACK
[2013-03-04 12:25:51.541] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:25:51.543] SendData Response with callback 0x05 received: received by recipient
[2013-03-04 12:25:51.544] SETDATA devices.8.data.lastSend = 128919 (0x0001f797)
[2013-03-04 12:25:51.545] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:25:51.546] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:25:51.547] Sending the queue for node 8 into sleep
[2013-03-04 12:25:51.547] Removing job: Wakeup Sleep
[2013-03-04 12:26:10.415] Job 0x13: deleted from queue
[2013-03-04 12:26:17.092] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:26:17.101] SENT ACK
[2013-03-04 12:26:17.102] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:26:17.103] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396377 (0x513484d9)
[2013-03-04 12:26:17.104] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:26:17.105] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:26:17.106] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:26:17.107] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:26:17.109] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:26:17.110] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:26:17.111] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:26:17.112] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:26:17.113] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:26:17.114] Trying to create command for unknown CC 0x46
[2013-03-04 12:26:17.115] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:26:17.115] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:26:17.117] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396377 (0x513484d9)
[2013-03-04 12:26:17.117] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:26:17.118] Running wakeup handler for node 8
[2013-03-04 12:26:17.120] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396377 (0x513484d9)
[2013-03-04 12:26:17.121] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:26:17.122] Adding job: Wakeup Sleep
[2013-03-04 12:26:17.134] SENDING (cb 0x06): ( 01 09 00 13 08 02 84 08 05 06 60 )
[2013-03-04 12:26:17.147] RECEIVED ACK
[2013-03-04 12:26:17.158] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:26:17.160] SENT ACK
[2013-03-04 12:26:17.161] Delivered to Z-Wave stack
[2013-03-04 12:26:17.173] RECEIVED: ( 01 05 00 13 06 00 EF )
[2013-03-04 12:26:17.174] SENT ACK
[2013-03-04 12:26:17.175] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:26:17.175] SendData Response with callback 0x06 received: received by recipient
[2013-03-04 12:26:17.176] SETDATA devices.8.data.lastSend = 131192 (0x00020078)
[2013-03-04 12:26:17.178] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:26:17.179] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:26:17.180] Sending the queue for node 8 into sleep
[2013-03-04 12:26:17.181] Removing job: Wakeup Sleep
[2013-03-04 12:26:18.115] RECEIVED: ( 01 08 00 04 00 04 02 84 07 76 )
[2013-03-04 12:26:18.124] SENT ACK
[2013-03-04 12:26:18.125] SETDATA devices.4.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:26:18.126] Node 4:0 CC Wakeup: Wakeup notification
[2013-03-04 12:26:18.126] SETDATA devices.4.instances.0.commandClasses.132.data.lastWakeup = 1362396378 (0x513484da)
[2013-03-04 12:26:18.127] SETDATA devices.4.data.isAwake = True
[2013-03-04 12:26:18.128] Running wakeup handler for node 4
[2013-03-04 12:26:18.129] SETDATA devices.4.instances.0.commandClasses.132.data.lastSleep = 1362396378 (0x513484da)
[2013-03-04 12:26:18.131] Node 4:0 CC Wakeup: Send node to sleep
[2013-03-04 12:26:18.134] Adding job: Wakeup Sleep
[2013-03-04 12:26:18.146] SENDING (cb 0x07): ( 01 09 00 13 04 02 84 08 05 07 6D )
[2013-03-04 12:26:18.159] RECEIVED ACK
[2013-03-04 12:26:18.170] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:26:18.172] SENT ACK
[2013-03-04 12:26:18.173] Delivered to Z-Wave stack
[2013-03-04 12:26:18.184] RECEIVED: ( 01 05 00 13 07 00 EE )
[2013-03-04 12:26:18.186] SENT ACK
[2013-03-04 12:26:18.188] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:26:18.188] SendData Response with callback 0x07 received: received by recipient
[2013-03-04 12:26:18.189] SETDATA devices.4.data.lastSend = 131279 (0x000200cf)
[2013-03-04 12:26:18.190] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:26:18.191] SETDATA devices.4.data.isAwake = False
[2013-03-04 12:26:18.191] Sending the queue for node 4 into sleep
[2013-03-04 12:26:18.192] Removing job: Wakeup Sleep
[2013-03-04 12:26:36.139] Job 0x13: deleted from queue
[2013-03-04 12:26:37.075] Job 0x13: deleted from queue
[2013-03-04 12:26:42.731] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:26:42.741] SENT ACK
[2013-03-04 12:26:42.742] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:26:42.743] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396402 (0x513484f2)
[2013-03-04 12:26:42.745] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:26:42.746] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:26:42.747] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:26:42.748] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:26:42.749] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:26:42.750] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:26:42.750] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:26:42.751] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:26:42.753] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:26:42.754] Trying to create command for unknown CC 0x46
[2013-03-04 12:26:42.754] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:26:42.755] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:26:42.756] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396402 (0x513484f2)
[2013-03-04 12:26:42.757] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:26:42.758] Running wakeup handler for node 8
[2013-03-04 12:26:42.759] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396402 (0x513484f2)
[2013-03-04 12:26:42.760] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:26:42.761] Adding job: Wakeup Sleep
[2013-03-04 12:26:42.773] SENDING (cb 0x08): ( 01 09 00 13 08 02 84 08 05 08 6E )
[2013-03-04 12:26:42.788] RECEIVED ACK
[2013-03-04 12:26:42.798] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:26:42.801] SENT ACK
[2013-03-04 12:26:42.801] Delivered to Z-Wave stack
[2013-03-04 12:26:42.812] RECEIVED: ( 01 05 00 13 08 00 E1 )
[2013-03-04 12:26:42.816] SENT ACK
[2013-03-04 12:26:42.817] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:26:42.819] SendData Response with callback 0x08 received: received by recipient
[2013-03-04 12:26:42.820] SETDATA devices.8.data.lastSend = 133461 (0x00020955)
[2013-03-04 12:26:42.820] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:26:42.821] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:26:42.822] Sending the queue for node 8 into sleep
[2013-03-04 12:26:42.823] Removing job: Wakeup Sleep
[2013-03-04 12:26:47.365] RECEIVED: ( 01 08 00 04 00 03 02 84 07 71 )
[2013-03-04 12:26:47.373] SENT ACK
[2013-03-04 12:26:47.374] SETDATA devices.3.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:26:47.375] Node 3:0 CC Wakeup: Wakeup notification
[2013-03-04 12:26:47.376] SETDATA devices.3.instances.0.commandClasses.132.data.lastWakeup = 1362396407 (0x513484f7)
[2013-03-04 12:26:47.377] SETDATA devices.3.data.isAwake = True
[2013-03-04 12:26:47.378] Running wakeup handler for node 3
[2013-03-04 12:26:47.379] SETDATA devices.3.instances.0.commandClasses.132.data.lastSleep = 1362396407 (0x513484f7)
[2013-03-04 12:26:47.380] Node 3:0 CC Wakeup: Send node to sleep
[2013-03-04 12:26:47.381] Adding job: Wakeup Sleep
[2013-03-04 12:26:47.394] SENDING (cb 0x09): ( 01 09 00 13 03 02 84 08 05 09 64 )
[2013-03-04 12:26:47.410] RECEIVED ACK
[2013-03-04 12:26:47.420] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:26:47.422] SENT ACK
[2013-03-04 12:26:47.423] Delivered to Z-Wave stack
[2013-03-04 12:26:47.434] RECEIVED: ( 01 05 00 13 09 00 E0 )
[2013-03-04 12:26:47.436] SENT ACK
[2013-03-04 12:26:47.437] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:26:47.438] SendData Response with callback 0x09 received: received by recipient
[2013-03-04 12:26:47.440] SETDATA devices.3.data.lastSend = 133868 (0x00020aec)
[2013-03-04 12:26:47.441] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:26:47.442] SETDATA devices.3.data.isAwake = False
[2013-03-04 12:26:47.442] Sending the queue for node 3 into sleep
[2013-03-04 12:26:47.443] Removing job: Wakeup Sleep
[2013-03-04 12:27:01.787] Job 0x13: deleted from queue
[2013-03-04 12:27:06.327] Job 0x13: deleted from queue
[2013-03-04 12:27:08.377] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:27:08.388] SENT ACK
[2013-03-04 12:27:08.388] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:27:08.390] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396428 (0x5134850c)
[2013-03-04 12:27:08.391] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:27:08.392] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:27:08.394] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:27:08.394] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:27:08.395] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:27:08.395] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:27:08.397] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:27:08.398] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:27:08.399] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:27:08.400] Trying to create command for unknown CC 0x46
[2013-03-04 12:27:08.400] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:27:08.401] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:27:08.402] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396428 (0x5134850c)
[2013-03-04 12:27:08.403] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:27:08.403] Running wakeup handler for node 8
[2013-03-04 12:27:08.405] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396428 (0x5134850c)
[2013-03-04 12:27:08.406] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:27:08.407] Adding job: Wakeup Sleep
[2013-03-04 12:27:08.420] SENDING (cb 0x0a): ( 01 09 00 13 08 02 84 08 05 0A 6C )
[2013-03-04 12:27:08.433] RECEIVED ACK
[2013-03-04 12:27:08.443] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:27:08.446] SENT ACK
[2013-03-04 12:27:08.446] Delivered to Z-Wave stack
[2013-03-04 12:27:08.457] RECEIVED: ( 01 05 00 13 0A 00 E3 )
[2013-03-04 12:27:08.459] SENT ACK
[2013-03-04 12:27:08.460] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:27:08.461] SendData Response with callback 0x0a received: received by recipient
[2013-03-04 12:27:08.462] SETDATA devices.8.data.lastSend = 135730 (0x00021232)
[2013-03-04 12:27:08.463] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:27:08.464] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:27:08.465] Sending the queue for node 8 into sleep
[2013-03-04 12:27:08.466] Removing job: Wakeup Sleep
[2013-03-04 12:27:27.343] Job 0x13: deleted from queue
[2013-03-04 12:27:34.005] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:27:34.015] SENT ACK
[2013-03-04 12:27:34.016] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:27:34.017] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396454 (0x51348526)
[2013-03-04 12:27:34.018] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:27:34.020] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:27:34.021] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:27:34.022] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:27:34.022] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:27:34.024] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:27:34.025] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:27:34.026] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:27:34.027] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:27:34.028] Trying to create command for unknown CC 0x46
[2013-03-04 12:27:34.029] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:27:34.030] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:27:34.030] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396454 (0x51348526)
[2013-03-04 12:27:34.031] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:27:34.032] Running wakeup handler for node 8
[2013-03-04 12:27:34.032] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396454 (0x51348526)
[2013-03-04 12:27:34.034] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:27:34.035] Adding job: Wakeup Sleep
[2013-03-04 12:27:34.036] SENDING (cb 0x0b): ( 01 09 00 13 08 02 84 08 05 0B 6D )
[2013-03-04 12:27:34.050] RECEIVED ACK
[2013-03-04 12:27:34.061] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:27:34.062] SENT ACK
[2013-03-04 12:27:34.063] Delivered to Z-Wave stack
[2013-03-04 12:27:34.075] RECEIVED: ( 01 05 00 13 0B 00 E2 )
[2013-03-04 12:27:34.079] SENT ACK
[2013-03-04 12:27:34.080] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:27:34.081] SendData Response with callback 0x0b received: received by recipient
[2013-03-04 12:27:34.082] SETDATA devices.8.data.lastSend = 138001 (0x00021b11)
[2013-03-04 12:27:34.082] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:27:34.083] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:27:34.085] Sending the queue for node 8 into sleep
[2013-03-04 12:27:34.086] Removing job: Wakeup Sleep
[2013-03-04 12:27:52.966] Job 0x13: deleted from queue
[2013-03-04 12:27:59.630] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:27:59.642] SENT ACK
[2013-03-04 12:27:59.643] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:27:59.645] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396479 (0x5134853f)
[2013-03-04 12:27:59.646] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:27:59.646] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:27:59.648] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:27:59.648] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:27:59.650] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:27:59.650] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:27:59.652] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:27:59.652] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:27:59.654] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:27:59.654] Trying to create command for unknown CC 0x46
[2013-03-04 12:27:59.655] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:27:59.655] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:27:59.656] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396479 (0x5134853f)
[2013-03-04 12:27:59.657] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:27:59.658] Running wakeup handler for node 8
[2013-03-04 12:27:59.660] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396479 (0x5134853f)
[2013-03-04 12:27:59.661] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:27:59.661] Adding job: Wakeup Sleep
[2013-03-04 12:27:59.673] SENDING (cb 0x0c): ( 01 09 00 13 08 02 84 08 05 0C 6A )
[2013-03-04 12:27:59.687] RECEIVED ACK
[2013-03-04 12:27:59.697] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:27:59.699] SENT ACK
[2013-03-04 12:27:59.700] Delivered to Z-Wave stack
[2013-03-04 12:27:59.711] RECEIVED: ( 01 05 00 13 0C 00 E5 )
[2013-03-04 12:27:59.713] SENT ACK
[2013-03-04 12:27:59.714] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:27:59.715] SendData Response with callback 0x0c received: received by recipient
[2013-03-04 12:27:59.716] SETDATA devices.8.data.lastSend = 140273 (0x000223f1)
[2013-03-04 12:27:59.717] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:27:59.717] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:27:59.718] Sending the queue for node 8 into sleep
[2013-03-04 12:27:59.719] Removing job: Wakeup Sleep
[2013-03-04 12:28:18.593] Job 0x13: deleted from queue
[2013-03-04 12:28:25.255] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:28:25.266] SENT ACK
[2013-03-04 12:28:25.267] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:28:25.268] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396505 (0x51348559)
[2013-03-04 12:28:25.269] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:28:25.270] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:28:25.271] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:28:25.272] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:28:25.273] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:28:25.274] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:28:25.275] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:28:25.277] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:28:25.278] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:28:25.280] Trying to create command for unknown CC 0x46
[2013-03-04 12:28:25.280] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:28:25.281] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:28:25.282] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396505 (0x51348559)
[2013-03-04 12:28:25.282] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:28:25.283] Running wakeup handler for node 8
[2013-03-04 12:28:25.284] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396505 (0x51348559)
[2013-03-04 12:28:25.285] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:28:25.287] Adding job: Wakeup Sleep
[2013-03-04 12:28:25.299] SENDING (cb 0x0d): ( 01 09 00 13 08 02 84 08 05 0D 6B )
[2013-03-04 12:28:25.312] RECEIVED ACK
[2013-03-04 12:28:25.323] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:28:25.325] SENT ACK
[2013-03-04 12:28:25.326] Delivered to Z-Wave stack
[2013-03-04 12:28:25.337] RECEIVED: ( 01 05 00 13 0D 00 E4 )
[2013-03-04 12:28:25.339] SENT ACK
[2013-03-04 12:28:25.340] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:28:25.341] SendData Response with callback 0x0d received: received by recipient
[2013-03-04 12:28:25.342] SETDATA devices.8.data.lastSend = 142545 (0x00022cd1)
[2013-03-04 12:28:25.343] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:28:25.344] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:28:25.345] Sending the queue for node 8 into sleep
[2013-03-04 12:28:25.346] Removing job: Wakeup Sleep
[2013-03-04 12:28:44.219] Job 0x13: deleted from queue
[2013-03-04 12:28:50.882] RECEIVED: ( 01 1C 00 04 00 08 16 8F 01 04 03 80 03 28 06 43 03 01 42 06 A4 04 46 08 00 7F 02 84 07 C8 )
[2013-03-04 12:28:50.893] SENT ACK
[2013-03-04 12:28:50.893] SETDATA devices.8.data.lastReceived = 0 (0x00000000)
[2013-03-04 12:28:50.894] SETDATA devices.8.instances.0.commandClasses.128.data.history.40 = 1362396530 (0x51348572)
[2013-03-04 12:28:50.895] SETDATA devices.8.instances.0.commandClasses.128.data.last = 40 (0x00000028)
[2013-03-04 12:28:50.896] SETDATA devices.8.instances.0.commandClasses.67.data.1.size = 2 (0x00000002)
[2013-03-04 12:28:50.897] SETDATA devices.8.instances.0.commandClasses.67.data.1.precision = 2 (0x00000002)
[2013-03-04 12:28:50.898] SETDATA devices.8.instances.0.commandClasses.67.data.1.scale = 0 (0x00000000)
[2013-03-04 12:28:50.899] SETDATA devices.8.instances.0.commandClasses.67.data.1.scaleString = "grd C"
[2013-03-04 12:28:50.900] SETDATA devices.8.instances.0.commandClasses.67.data.1.val = 17.000000
[2013-03-04 12:28:50.900] SETDATA devices.8.instances.0.commandClasses.67.data.1.setVal = 17.000000
[2013-03-04 12:28:50.901] SETDATA devices.8.instances.0.commandClasses.67.data.1 = Empty
[2013-03-04 12:28:50.903] Node 8:0 CC MultiCmd: Received command, but CC 0x46 isn't registered. Creating it as not supported
[2013-03-04 12:28:50.904] Trying to create command for unknown CC 0x46
[2013-03-04 12:28:50.904] Error returned from _zway_cc_call_handler(zway, cmd, node_id, instance_id, len, &data[idx + 1]): Bad arguments (-1)
[2013-03-04 12:28:50.905] Node 8:0 CC Wakeup: Wakeup notification
[2013-03-04 12:28:50.906] SETDATA devices.8.instances.0.commandClasses.132.data.lastWakeup = 1362396530 (0x51348572)
[2013-03-04 12:28:50.907] SETDATA devices.8.data.isAwake = True
[2013-03-04 12:28:50.907] Running wakeup handler for node 8
[2013-03-04 12:28:50.908] SETDATA devices.8.instances.0.commandClasses.132.data.lastSleep = 1362396530 (0x51348572)
[2013-03-04 12:28:50.909] Node 8:0 CC Wakeup: Send node to sleep
[2013-03-04 12:28:50.910] Adding job: Wakeup Sleep
[2013-03-04 12:28:50.923] SENDING (cb 0x0e): ( 01 09 00 13 08 02 84 08 05 0E 68 )
[2013-03-04 12:28:50.935] RECEIVED ACK
[2013-03-04 12:28:50.946] RECEIVED: ( 01 04 01 13 01 E8 )
[2013-03-04 12:28:50.948] SENT ACK
[2013-03-04 12:28:50.949] Delivered to Z-Wave stack
[2013-03-04 12:28:50.960] RECEIVED: ( 01 05 00 13 0E 00 E7 )
[2013-03-04 12:28:50.961] SENT ACK
[2013-03-04 12:28:50.963] Job 0x13 (Wakeup Sleep): Delivered
[2013-03-04 12:28:50.964] SendData Response with callback 0x0e received: received by recipient
[2013-03-04 12:28:50.965] SETDATA devices.8.data.lastSend = 144817 (0x000235b1)
[2013-03-04 12:28:50.965] Job 0x13 (Wakeup Sleep): success
[2013-03-04 12:28:50.966] SETDATA devices.8.data.isAwake = False
[2013-03-04 12:28:50.967] Sending the queue for node 8 into sleep
[2013-03-04 12:28:50.968] Removing job: Wakeup Sleep
[2013-03-04 12:29:09.853] Job 0x13: deleted from queue
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.026] Adding job: Get routing table line
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.030] Adding job: Request node neighbours update
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.034] SENDING (cb 0x00): ( 01 06 00 80 01 00 00 78 )
[2013-03-04 12:29:16.040] Adding job: Request node neighbours update
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.045] Adding job: Request node neighbours update
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.049] Adding job: Request update of network topology from SUC/SIS
[2013-03-04 12:29:16.051] RECEIVED ACK
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.054] Adding job: Request node neighbours update
[2013-03-04 12:29:16.062] RECEIVED: ( 01 20 01 80 BC 0C 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 EE )
[2013-03-04 12:29:16.069] SENT ACK
[2013-03-04 12:29:16.071] SETDATA devices.1.data.neighbours = byte[7]
( 03 04 05 06 08 0B 0C )
[2013-03-04 12:29:16.074] Job 0x80 (Get routing table line): List of neighbours for node 1: [ 03 04 05 06 08 0b 0c ]
[2013-03-04 12:29:16.075] Job 0x80 (Get routing table line): success
[2013-03-04 12:29:16.076] Removing job: Get routing table line
[2013-03-04 12:29:16.087] SENDING (cb 0x0f): ( 01 05 00 48 05 0F B8 )
[2013-03-04 12:29:16.100] RECEIVED ACK
[2013-03-04 12:29:16.112] RECEIVED: ( 01 05 00 48 0F 21 9C )
[2013-03-04 12:29:16.115] SENT ACK
[2013-03-04 12:29:16.116] Job 0x48 (Request node neighbours update): Neighbour update started for node 5
Exeсuting script: zway.devices[7].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.138] Adding job: Request node neighbours update
Exeсuting script: zway.devices[9].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.142] Adding job: Request node neighbours update
Exeсuting script: zway.devices[8].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.147] Adding job: Request node neighbours update
Exeсuting script: zway.devices[11].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.151] Adding job: Request node neighbours update
Exeсuting script: zway.devices[12].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.156] Adding job: Request node neighbours update
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.182] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.238] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.243] Adding job: Request node neighbours update
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.247] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.251] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.256] Adding job: Get routing table line
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.353] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[11].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.357] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[12].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.362] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[9].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.366] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[8].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.371] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[7].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.376] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.513] Job 0x80 (Get routing table line): removing duplicate
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.517] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.522] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.526] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.531] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.536] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[7].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.614] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[8].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.619] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[9].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.633] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[11].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.639] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[12].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.645] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.660] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.720] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.725] Job 0x80 (Get routing table line): removing duplicate
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.729] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.734] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.739] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.805] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[8].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.826] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[7].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.830] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[9].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.835] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[12].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.839] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[11].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.844] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.953] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.957] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.962] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.967] Job 0x80 (Get routing table line): removing duplicate
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:16.971] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:16.975] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[8].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.066] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[11].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.071] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[7].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.076] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[9].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.080] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[12].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.085] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.controller.RequestNetworkUpdate()
[2013-03-04 12:29:17.151] Job 0x53 (Request update of network topology from SUC/SIS): removing duplicate
Exeсuting script: zway.devices[1].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.169] Job 0x80 (Get routing table line): removing duplicate
Exeсuting script: zway.devices[3].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.174] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[4].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.179] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[5].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.183] Job 0x48 (Request node neighbours update): removing duplicate
Exeсuting script: zway.devices[6].RequestNodeNeighbourUpdate()
[2013-03-04 12:29:17.198] Job 0x48 (Request node neighbours update): removing duplicate
[2013-03-04 12:29:20.751] RECEIVED: ( 01 05 00 48 0F 22 9F )
[2013-03-04 12:29:20.758] SENT ACK
[2013-03-04 12:29:20.759] Job 0x48 (Request node neighbours update): Neighbour update done for node 5
[2013-03-04 12:29:20.761] Job 0x48 (Request node neighbours update): success
[2013-03-04 12:29:20.762] Adding job: Get routing table line
[2013-03-04 12:29:20.763] Removing job: Request node neighbours update
[2013-03-04 12:29:20.775] SENDING (cb 0x10): ( 01 05 00 48 0B 10 A9 )
[2013-03-04 12:29:20.788] RECEIVED ACK
[2013-03-04 12:29:20.798] RECEIVED: ( 01 05 00 48 10 21 83 )
[2013-03-04 12:29:20.801] SENT ACK
[2013-03-04 12:29:20.803] Job 0x48 (Request node neighbours update): Neighbour update started for node 11
pi@rpi1 ~ $
^^^^^^^^^^^^^^^
As you can see, there is just a silent exit...
Post Reply