This page last changed on Jun 15, 2013 by juha.

I have my Z-wave devices set up so I thought I would add a rule to turn the aquarium light off at 10:30pm every day. The light is plugged into a Z-wave outlet that has the command "Fish off" so I adjusted the rule from the tutorial:

"package org.openremote.controller.protocol

global org.openremote.controller.statuscache.CommandFacade execute;
global org.openremote.controller.statuscache.SwitchFacade switches;

rule "Fish Light off"

timer (cron: 0 30 22 * * ?) when eval (true) then

execute.command("Fish off");

end"

After syncing the controller I get a constant stream of errors that never stop:

Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-15]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-18]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
Exception in thread "Thread-35" java.lang.NullPointerException
        at org.openremote.controller.statuscache.rules.RuleEngine.push(RuleEngin
e.java:145)
        at org.openremote.controller.statuscache.EventProcessorChain.push(EventP
rocessorChain.java:188)
        at org.openremote.controller.statuscache.StatusCache.update(StatusCache.
java:260)
        at org.openremote.controller.model.sensor.Sensor.update(Sensor.java:342)

        at org.openremote.controller.protocol.zwave.model.Switch.updateSensors(S
witch.java:92)
        at org.openremote.controller.protocol.zwave.model.Switch.handleRequestMe
ssage(Switch.java:73)
        at org.openremote.controller.protocol.zwave.model.ZWaveNode.handleZWaveR
esponseEvent(ZWaveNode.java:152)
        at org.openremote.controller.protocol.zwave.ZWaveGateway.fireZWaveRespon
seEvent(ZWaveGateway.java:89)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveReader
Thread.run(ZWaveGatewayRxtx.java:266)
java.lang.InterruptedException: sleep interrupted
        at java.lang.Thread.sleep(Native Method)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:184)
ERROR [Thread-21]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-8]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-27]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-5]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-36]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-15]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-18]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-21]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-8]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-27]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-5]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-36]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-15]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-18]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-21]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-21]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-8]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-27]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-5]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-36]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-15]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-18]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-11]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-21]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-21]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-33]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-8]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-27]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-5]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-24]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-30]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-36]: could not send data: 01 09 00 13 05 02 20 02 05 03 c6
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
ERROR [Thread-36]: could not send data: 06
java.io.IOException
        at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
        at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)

How do I add something into a scrolling box in my posts? This is my Z-wave log after a few seconds of running. Removing the rule in designer and re-syncing doesn't fix the errors either, I have to replace modeler_rules.drl with another one.

INFO 2013-06-14 15:25:26,403 (Z-wave): Reader thread asked to start
INFO 2013-06-14 15:25:26,404 (Z-wave): Writer thread asked to start
INFO 2013-06-14 15:25:26,404 (Z-wave): Writer thread starting
DEBUG 2013-06-14 15:25:26,404 (Z-wave): sending: 01 08 00 54 00 01 01 01 01 a3 
DEBUG 2013-06-14 15:25:26,404 (Z-wave): Message lock exists. Frame waiting: 01 03 00 02 fe 
DEBUG 2013-06-14 15:25:26,407 (Z-wave): received: 06 01 04 01 54 00 ae 
DEBUG 2013-06-14 15:25:26,407 (Z-wave): Controller registered as SUC/SIS
DEBUG 2013-06-14 15:25:26,454 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,454 (Z-wave): sending: 01 03 00 02 fe 
DEBUG 2013-06-14 15:25:26,459 (Z-wave): received: 06 
DEBUG 2013-06-14 15:25:26,503 (Z-wave): received: 01 25 01 02 05 08 1d 1f 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 00 03 01 d4 
DEBUG 2013-06-14 15:25:26,503 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Node id: 1 discovered
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Node id: 2 discovered
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Node id: 3 discovered
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Node id: 4 discovered
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Node id: 5 discovered
DEBUG 2013-06-14 15:25:26,503 (Z-wave): sending: 01 04 00 41 01 bb 
DEBUG 2013-06-14 15:25:26,503 (Z-wave): Message lock exists. Frame waiting: 01 04 00 41 02 b8 
DEBUG 2013-06-14 15:25:26,507 (Z-wave): received: 06 01 09 01 41 92 96 00 02 02 01 b3 
DEBUG 2013-06-14 15:25:26,554 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,554 (Z-wave): sending: 01 04 00 41 02 b8 
DEBUG 2013-06-14 15:25:26,554 (Z-wave): Message lock exists. Frame waiting: 01 04 00 41 03 b9 
DEBUG 2013-06-14 15:25:26,556 (Z-wave): received: 06 
DEBUG 2013-06-14 15:25:26,560 (Z-wave): received: 01 09 01 41 d3 9c 00 04 11 01 ed 
DEBUG 2013-06-14 15:25:26,561 (Z-wave): Node: 2 created, Type: Dimmer, Listening: true
DEBUG 2013-06-14 15:25:26,604 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,604 (Z-wave): sending: 01 04 00 41 03 b9 
DEBUG 2013-06-14 15:25:26,604 (Z-wave): Message lock exists. Frame waiting: 01 04 00 41 04 be 
DEBUG 2013-06-14 15:25:26,609 (Z-wave): received: 06 01 09 01 41 d3 9c 00 04 11 01 ed 
DEBUG 2013-06-14 15:25:26,609 (Z-wave): Node: 3 created, Type: Dimmer, Listening: true
DEBUG 2013-06-14 15:25:26,654 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,654 (Z-wave): sending: 01 04 00 41 04 be 
DEBUG 2013-06-14 15:25:26,654 (Z-wave): Message lock exists. Frame waiting: 01 04 00 41 05 bf 
DEBUG 2013-06-14 15:25:26,658 (Z-wave): received: 06 01 09 01 41 d3 9c 00 04 10 01 ec 
DEBUG 2013-06-14 15:25:26,658 (Z-wave): Node: 4 created, Type: Switch, Listening: true
DEBUG 2013-06-14 15:25:26,704 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,704 (Z-wave): sending: 01 04 00 41 05 bf 
DEBUG 2013-06-14 15:25:26,706 (Z-wave): received: 06 
DEBUG 2013-06-14 15:25:26,710 (Z-wave): received: 01 09 01 41 d3 9c 00 04 10 01 ec 
DEBUG 2013-06-14 15:25:26,710 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:26,710 (Z-wave): Node: 5 created, Type: Switch, Listening: true
DEBUG 2013-06-14 15:25:26,899 (Z-wave): Building Z-Wave command
DEBUG 2013-06-14 15:25:26,899 (Z-wave): Z-Wave command: nodeId = 3
DEBUG 2013-06-14 15:25:26,899 (Z-wave): Z-Wave command: command = Status
DEBUG 2013-06-14 15:25:26,899 (Z-wave): Z-Wave command: paramValue = null
DEBUG 2013-06-14 15:25:26,899 (Z-wave): Z-Wave command created successfully
DEBUG 2013-06-14 15:25:26,914 (Z-wave): Building Z-Wave command
DEBUG 2013-06-14 15:25:26,915 (Z-wave): Z-Wave command: nodeId = 3
DEBUG 2013-06-14 15:25:26,915 (Z-wave): Z-Wave command: command = dim
DEBUG 2013-06-14 15:25:26,915 (Z-wave): Z-Wave command: paramValue = null
DEBUG 2013-06-14 15:25:26,915 (Z-wave): Z-Wave command created successfully
DEBUG 2013-06-14 15:25:26,924 (Z-wave): Building Z-Wave command
DEBUG 2013-06-14 15:25:26,924 (Z-wave): Z-Wave command: nodeId = 2
DEBUG 2013-06-14 15:25:26,924 (Z-wave): Z-Wave command: command = dim
DEBUG 2013-06-14 15:25:26,924 (Z-wave): Z-Wave command: paramValue = null
DEBUG 2013-06-14 15:25:26,925 (Z-wave): Z-Wave command created successfully
DEBUG 2013-06-14 15:25:26,934 (Z-wave): Building Z-Wave command
DEBUG 2013-06-14 15:25:26,934 (Z-wave): Z-Wave command: nodeId = 5
DEBUG 2013-06-14 15:25:26,934 (Z-wave): Z-Wave command: command = status
DEBUG 2013-06-14 15:25:26,934 (Z-wave): Z-Wave command: paramValue = null
DEBUG 2013-06-14 15:25:26,934 (Z-wave): Z-Wave command created successfully
DEBUG 2013-06-14 15:25:26,942 (Z-wave): Building Z-Wave command
DEBUG 2013-06-14 15:25:26,942 (Z-wave): Z-Wave command: nodeId = 2
DEBUG 2013-06-14 15:25:26,942 (Z-wave): Z-Wave command: command = status
DEBUG 2013-06-14 15:25:26,942 (Z-wave): Z-Wave command: paramValue = null
DEBUG 2013-06-14 15:25:26,942 (Z-wave): Z-Wave command created successfully
DEBUG 2013-06-14 15:25:26,943 (Z-wave): *** setSensor called as part of EventListener init *** sensor is: Switch Sensor (Name = 'LS1 Power', ID = '1148')
DEBUG 2013-06-14 15:25:27,443 (Z-wave): sending: 01 09 00 13 02 02 20 02 05 02 c0 
DEBUG 2013-06-14 15:25:27,443 (Z-wave): *** setSensor called as part of EventListener init *** sensor is: Switch Sensor (Name = 'Fish stat', ID = '1147')
DEBUG 2013-06-14 15:25:27,445 (Z-wave): received: 06 
DEBUG 2013-06-14 15:25:27,449 (Z-wave): received: 01 04 01 13 01 e8 
DEBUG 2013-06-14 15:25:27,449 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:27,461 (Z-wave): received: 01 05 00 13 02 00 eb 
DEBUG 2013-06-14 15:25:27,461 (Z-wave): sending: 06 
INFO 2013-06-14 15:25:27,466 (Z-wave): Reader thread is dead, clean and re-try to connect
INFO 2013-06-14 15:25:27,511 (Z-wave): Reader thread asked to start
INFO 2013-06-14 15:25:27,511 (Z-wave): Writer thread asked to start
INFO 2013-06-14 15:25:27,511 (Z-wave): Writer thread starting
DEBUG 2013-06-14 15:25:27,943 (Z-wave): sending: 01 09 00 13 05 02 20 02 05 03 c6 
ERROR 2013-06-14 15:25:27,943 (Z-wave): could not send data: 01 09 00 13 05 02 20 02 05 03 c6 
java.io.IOException
	at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
	at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriterThread.run(ZWaveGatewayRxtx.java:207)
DEBUG 2013-06-14 15:25:27,943 (Z-wave): *** setSensor called as part of EventListener init *** sensor is: Range Sensor (Name = 'LS1 Dim Level', ID = '1146', Min: 0, Max: 99)
DEBUG 2013-06-14 15:25:28,444 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,444 (Z-wave): *** setSensor called as part of EventListener init *** sensor is: Range Sensor (Name = 'LS2 Dim Level', ID = '1145', Min: 0, Max: 99)
DEBUG 2013-06-14 15:25:28,494 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,544 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,594 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,644 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,694 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,744 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,794 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,844 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,894 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,944 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,944 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 02 02 20 02 05 04 c6 
DEBUG 2013-06-14 15:25:28,944 (Z-wave): *** setSensor called as part of EventListener init *** sensor is: Switch Sensor (Name = 'LS2 Power', ID = '1144')
DEBUG 2013-06-14 15:25:28,968 (Z-wave): received: 01 09 00 04 00 02 03 20 03 00 d0 
INFO 2013-06-14 15:25:28,971 (Z-wave): Reader thread is dead, clean and re-try to connect
DEBUG 2013-06-14 15:25:28,994 (Z-wave): sending: 06 
DEBUG 2013-06-14 15:25:28,994 (Z-wave): sending: 01 09 00 13 02 02 20 02 05 04 c6 
ERROR 2013-06-14 15:25:28,994 (Z-wave): could not send data: 06 
java.io.IOException
	at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
	at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriterThread.run(ZWaveGatewayRxtx.java:207)
DEBUG 2013-06-14 15:25:28,994 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:28,994 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,008 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
INFO 2013-06-14 15:25:29,016 (Z-wave): Reader thread asked to start
INFO 2013-06-14 15:25:29,016 (Z-wave): Writer thread asked to start
INFO 2013-06-14 15:25:29,016 (Z-wave): Writer thread starting
DEBUG 2013-06-14 15:25:29,016 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,044 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,058 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,066 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,094 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,108 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,116 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,144 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,158 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,166 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,194 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,208 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,216 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,244 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,258 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,266 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,294 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,308 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,316 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,344 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,358 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,366 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,394 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,408 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,416 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,444 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,458 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,466 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,494 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,508 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,516 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,545 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,559 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,567 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,595 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,609 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,617 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,645 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,659 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,667 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,695 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,709 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,717 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,745 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,759 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,767 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,795 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,809 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,817 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,845 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,859 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,867 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,895 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,909 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,917 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,945 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,959 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,967 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:29,995 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,009 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,017 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,045 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,059 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,067 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,095 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,109 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,117 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,145 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,159 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,167 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,195 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,209 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,217 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,245 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,259 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,267 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,295 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,309 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,317 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,345 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,359 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,367 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,395 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,409 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,417 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,445 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,459 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,467 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,469 (Z-wave): received: 01 09 00 04 00 02 03 20 03 00 d0 
INFO 2013-06-14 15:25:30,470 (Z-wave): Reader thread is dead, clean and re-try to connect
DEBUG 2013-06-14 15:25:30,481 (Z-wave): sending: 06 
ERROR 2013-06-14 15:25:30,481 (Z-wave): could not send data: 06 
java.io.IOException
	at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
	at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriterThread.run(ZWaveGatewayRxtx.java:207)
DEBUG 2013-06-14 15:25:30,482 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
INFO 2013-06-14 15:25:30,490 (Z-wave): Reader thread asked to start
INFO 2013-06-14 15:25:30,490 (Z-wave): Writer thread asked to start
INFO 2013-06-14 15:25:30,490 (Z-wave): Writer thread starting
DEBUG 2013-06-14 15:25:30,490 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,495 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,509 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,532 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,540 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,545 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,559 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,582 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,590 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,595 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,609 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,632 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,640 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,645 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,659 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,682 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,690 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,695 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,709 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,732 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,740 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,745 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,759 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,782 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,790 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,795 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,809 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,832 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,840 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,845 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,859 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,882 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,890 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,895 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,909 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,932 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,940 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,945 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,959 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,982 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,990 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:30,995 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,009 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,033 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,041 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,046 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,060 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,083 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,091 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,096 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,110 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,133 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,141 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,146 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,160 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,183 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,191 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,196 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,210 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,233 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,241 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,246 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,260 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,283 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,291 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,296 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,310 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,333 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,341 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,346 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,360 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,383 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,391 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,396 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,410 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,433 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,441 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,446 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,460 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,483 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,491 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,496 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,510 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,533 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,541 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,546 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,560 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,583 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,591 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,596 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,610 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,633 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,641 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,646 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,660 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,683 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,691 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,696 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,710 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,733 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,741 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,746 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,760 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,783 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,791 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,796 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,810 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,833 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,841 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,846 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 
DEBUG 2013-06-14 15:25:31,860 (Z-wave): Message lock exists. Frame waiting: 01 09 00 13 03 02 20 02 05 05 c6 

Posted by crossbred900 at Jun 14, 2013 20:26

How do I add something into a scrolling box in my posts?

Surround it with either {noformat} or {code} tags.

Posted by juha at Jun 15, 2013 01:43

Hmm the first one is an interesting log. Most of it is I/O errors from your serial (USB) port. The one that made it interesting is a thread interrupt and a null pointer exception on the rule engine event context which normally shouldn't happen.

I'm not quite sure what to make of it.

Posted by juha at Jun 15, 2013 01:53

The second log show just I/O exceptions on the serial (USB) port. Normally I would guess that there's a lock on the port maybe that's preventing sending of the data. The first log showed some odd errors though.

Have you made any progress in debugging this further?

Posted by juha at Jun 15, 2013 01:54

I'm not sure what to try. I did get quicker at copying the scrolling text, this is the start.

<code>Microsoft Windows Version 6.2.9200
(c) 2012 Microsoft Corporation. All rights reserved.

C:\Users\Megatron>cd c:/openremote/openremote-controller-2.0.1\bin

c:\Openremote\OpenRemote-Controller-2.0.1\bin>openremote run
Using CATALINA_BASE: c:\Openremote\OpenRemote-Controller-2.0.1
Using CATALINA_HOME: c:\Openremote\OpenRemote-Controller-2.0.1
Using CATALINA_TMPDIR: c:\Openremote\OpenRemote-Controller-2.0.1\temp
Using JRE_HOME: C:\Program Files\Java\jre7
Jun 14, 2013 10:43:39 PM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performanc
e in production environments was not found on the java.library.path: c:\Openremo
te\OpenRemote-Controller-2.0.1\webapps\controller\WEB-INF\lib\native
Jun 14, 2013 10:43:39 PM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
Jun 14, 2013 10:43:39 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 221 ms
Jun 14, 2013 10:43:39 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Jun 14, 2013 10:43:39 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
Jun 14, 2013 10:43:39 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive webconsole.war
Jun 14, 2013 10:43:39 PM org.openremote.controller.bootstrap.Startup redirectJUL
toLog4j
INFO: Initialized JUL to LOG4J Redirector.
INFO 2013-06-14 22:43:40,429 :

--------------------------------------------------------------------

DEPLOYING NEW CONTROLLER RUNTIME...

--------------------------------------------------------------------

WARNING: RXTX Version mismatch
Jar version = RXTX-2.2pre1
native lib Version = RXTX-2.2-20081207 Cloudhopper Build rxtx.cloudhoppe
r.net
INFO 2013-06-14 22:43:40,981 : No rule definitions found in 'c:\Openremote\OpenR
emote-Controller-2.0.1\webapps\controller\rules'.
INFO 2013-06-14 22:43:40,982 : Initialized event processor : Drools Rule Engine
INFO 2013-06-14 22:43:41,016 : Initialized event processor : RRD4J Data Logger
INFO 2013-06-14 22:43:41,079 : Registered sensor : Switch Sensor (Name = 'LS1 Po
wer', ID = '1148')
INFO 2013-06-14 22:43:41,579 : Registered sensor : Switch Sensor (Name = 'Fish s
tat', ID = '1147')
INFO 2013-06-14 22:43:42,080 : Registered sensor : Range Sensor (Name = 'LS1 Dim
Level', ID = '1146', Min: 0, Max: 99)
INFO 2013-06-14 22:43:42,580 : Registered sensor : Range Sensor (Name = 'LS2 Dim
Level', ID = '1145', Min: 0, Max: 99)
INFO 2013-06-14 22:43:43,080 : Registered sensor : Switch Sensor (Name = 'LS2 Po
wer', ID = '1144')
INFO 2013-06-14 22:43:43,581 : Startup complete.
INFO 2013-06-14 22:43:43,581 : Controller Definition File Watcher for Default De
ployer started.
Jun 14, 2013 10:43:43 PM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
Jun 14, 2013 10:43:43 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 4252 ms
INFO 2013-06-14 22:44:17,587 :

--------------------------------------------------------------------

UNDEPLOYING CURRENT CONTROLLER RUNTIME...

--------------------------------------------------------------------

INFO 2013-06-14 22:44:17,587 : Stopped event processor : Drools Rule Engine
INFO 2013-06-14 22:44:17,593 : Stopped event processor : RRD4J Data Logger
INFO 2013-06-14 22:44:17,593 : Shutdown complete.
INFO 2013-06-14 22:44:17,594 :

--------------------------------------------------------------------

DEPLOYING NEW CONTROLLER RUNTIME...

--------------------------------------------------------------------

ERROR 2013-06-14 22:44:17,773 : Cannot start event processor 'Drools Rule Engine
' : Unable to load dialect 'org.drools.rule.builder.dialect.java.JavaDialectConf
iguration:java:org.drools.rule.builder.dialect.java.JavaDialectConfiguration'
org.drools.RuntimeDroolsException: Unable to load dialect 'org.drools.rule.build
er.dialect.java.JavaDialectConfiguration:java:org.drools.rule.builder.dialect.ja
va.JavaDialectConfiguration'
at org.drools.compiler.PackageBuilderConfiguration.addDialect(PackageBui
lderConfiguration.java:283)
at org.drools.compiler.PackageBuilderConfiguration.buildDialectConfigura
tionMap(PackageBuilderConfiguration.java:268)
at org.drools.compiler.PackageBuilderConfiguration.init(PackageBuilderCo
nfiguration.java:181)
at org.drools.compiler.PackageBuilderConfiguration.<init>(PackageBuilder
Configuration.java:159)
at org.drools.compiler.PackageBuilder.<init>(PackageBuilder.java:210)
at org.drools.compiler.PackageBuilder.<init>(PackageBuilder.java:143)
at org.drools.builder.impl.KnowledgeBuilderFactoryServiceImpl.newKnowled
geBuilder(KnowledgeBuilderFactoryServiceImpl.java:34)
at org.drools.builder.KnowledgeBuilderFactory.newKnowledgeBuilder(Knowle
dgeBuilderFactory.java:47)
at org.openremote.controller.statuscache.rules.RuleEngine.getValidKnowle
dgePackages(RuleEngine.java:484)
at org.openremote.controller.statuscache.rules.RuleEngine.start(RuleEngi
ne.java:253)
at org.openremote.controller.statuscache.EventProcessorChain.start(Event
ProcessorChain.java:112)
at org.openremote.controller.statuscache.StatusCache.start(StatusCache.j
ava:120)
at org.openremote.controller.deployer.Version20ModelBuilder.buildSensorM
odel(Version20ModelBuilder.java:633)
at org.openremote.controller.deployer.Version20ModelBuilder.build(Versio
n20ModelBuilder.java:555)
at org.openremote.controller.deployer.AbstractModelBuilder.buildModel(Ab
stractModelBuilder.java:154)
at org.openremote.controller.service.Deployer.startup(Deployer.java:840)

at org.openremote.controller.service.Deployer.softRestart(Deployer.java:
420)
at org.openremote.controller.service.Deployer$ControllerDefinitionWatch.
run(Deployer.java:1268)
at java.lang.Thread.run(Unknown Source)
Caused by: org.drools.RuntimeDroolsException: value '1.7' is not a valid languag
e level
at org.drools.rule.builder.dialect.java.JavaDialectConfiguration.getDefa
ultLanguageLevel(JavaDialectConfiguration.java:162)
at org.drools.rule.builder.dialect.java.JavaDialectConfiguration.init(Ja
vaDialectConfiguration.java:57)
at org.drools.compiler.PackageBuilderConfiguration.addDialect(PackageBui
lderConfiguration.java:279)
... 18 more
ERROR Controller Definition File Watcher for Default Deployer: Cannot start ev
ent processor 'Drools Rule Engine' : Unable to load dialect 'org.drools.rule.bui
lder.dialect.java.JavaDialectConfiguration:java:org.drools.rule.builder.dialect.
java.JavaDialectConfiguration'
org.drools.RuntimeDroolsException: Unable to load dialect 'org.drools.rule.build
er.dialect.java.JavaDialectConfiguration:java:org.drools.rule.builder.dialect.ja
va.JavaDialectConfiguration'
at org.drools.compiler.PackageBuilderConfiguration.addDialect(PackageBui
lderConfiguration.java:283)
at org.drools.compiler.PackageBuilderConfiguration.buildDialectConfigura
tionMap(PackageBuilderConfiguration.java:268)
at org.drools.compiler.PackageBuilderConfiguration.init(PackageBuilderCo
nfiguration.java:181)
at org.drools.compiler.PackageBuilderConfiguration.<init>(PackageBuilder
Configuration.java:159)
at org.drools.compiler.PackageBuilder.<init>(PackageBuilder.java:210)
at org.drools.compiler.PackageBuilder.<init>(PackageBuilder.java:143)
at org.drools.builder.impl.KnowledgeBuilderFactoryServiceImpl.newKnowled
geBuilder(KnowledgeBuilderFactoryServiceImpl.java:34)
at org.drools.builder.KnowledgeBuilderFactory.newKnowledgeBuilder(Knowle
dgeBuilderFactory.java:47)
at org.openremote.controller.statuscache.rules.RuleEngine.getValidKnowle
dgePackages(RuleEngine.java:484)
at org.openremote.controller.statuscache.rules.RuleEngine.start(RuleEngi
ne.java:253)
at org.openremote.controller.statuscache.EventProcessorChain.start(Event
ProcessorChain.java:112)
at org.openremote.controller.statuscache.StatusCache.start(StatusCache.j
ava:120)
at org.openremote.controller.deployer.Version20ModelBuilder.buildSensorM
odel(Version20ModelBuilder.java:633)
at org.openremote.controller.deployer.Version20ModelBuilder.build(Versio
n20ModelBuilder.java:555)
at org.openremote.controller.deployer.AbstractModelBuilder.buildModel(Ab
stractModelBuilder.java:154)
at org.openremote.controller.service.Deployer.startup(Deployer.java:840)

at org.openremote.controller.service.Deployer.softRestart(Deployer.java:
420)
at org.openremote.controller.service.Deployer$ControllerDefinitionWatch.
run(Deployer.java:1268)
at java.lang.Thread.run(Unknown Source)
Caused by: org.drools.RuntimeDroolsException: value '1.7' is not a valid languag
e level
at org.drools.rule.builder.dialect.java.JavaDialectConfiguration.getDefa
ultLanguageLevel(JavaDialectConfiguration.java:162)
at org.drools.rule.builder.dialect.java.JavaDialectConfiguration.init(Ja
vaDialectConfiguration.java:57)
at org.drools.compiler.PackageBuilderConfiguration.addDialect(PackageBui
lderConfiguration.java:279)
... 18 more
INFO 2013-06-14 22:44:17,788 : Initialized event processor : RRD4J Data Logger
INFO 2013-06-14 22:44:17,858 : Registered sensor : Switch Sensor (Name = 'LS1 Po
wer', ID = '1148')
INFO 2013-06-14 22:44:18,358 : Registered sensor : Switch Sensor (Name = 'Fish s
tat', ID = '1147')
Exception in thread "Thread-4" java.lang.NullPointerException
at org.openremote.controller.statuscache.rules.RuleEngine.push(RuleEngin
e.java:145)
at org.openremote.controller.statuscache.EventProcessorChain.push(EventP
rocessorChain.java:188)
at org.openremote.controller.statuscache.StatusCache.update(StatusCache.
java:260)
at org.openremote.controller.model.sensor.Sensor.update(Sensor.java:342)

at org.openremote.controller.protocol.zwave.model.Switch.updateSensors(S
witch.java:92)
at org.openremote.controller.protocol.zwave.model.Switch.handleRequestMe
ssage(Switch.java:65)
at org.openremote.controller.protocol.zwave.model.ZWaveNode.handleZWaveR
esponseEvent(ZWaveNode.java:152)
at org.openremote.controller.protocol.zwave.ZWaveGateway.fireZWaveRespon
seEvent(ZWaveGateway.java:89)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveReader
Thread.run(ZWaveGatewayRxtx.java:266)
INFO 2013-06-14 22:44:18,858 : Registered sensor : Range Sensor (Name = 'LS1 Dim
Level', ID = '1146', Min: 0, Max: 99)
ERROR Thread\-5: could not send data: 01 09 00 13 05 02 20 02 05 08 cd
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
INFO 2013-06-14 22:44:19,359 : Registered sensor : Range Sensor (Name = 'LS2 Dim
Level', ID = '1145', Min: 0, Max: 99)
INFO 2013-06-14 22:44:19,859 : Registered sensor : Switch Sensor (Name = 'LS2 Po
wer', ID = '1144')
Exception in thread "Thread-8" java.lang.NullPointerException
at org.openremote.controller.statuscache.rules.RuleEngine.push(RuleEngin
e.java:145)
at org.openremote.controller.statuscache.EventProcessorChain.push(EventP
rocessorChain.java:188)
at org.openremote.controller.statuscache.StatusCache.update(StatusCache.
java:260)
at org.openremote.controller.model.sensor.Sensor.update(Sensor.java:342)

at org.openremote.controller.protocol.zwave.model.Switch.updateSensors(S
witch.java:92)
at org.openremote.controller.protocol.zwave.model.Switch.handleRequestMe
ssage(Switch.java:73)
at org.openremote.controller.protocol.zwave.model.ZWaveNode.handleZWaveR
esponseEvent(ZWaveNode.java:152)
at org.openremote.controller.protocol.zwave.ZWaveGateway.fireZWaveRespon
seEvent(ZWaveGateway.java:89)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveReader
Thread.run(ZWaveGatewayRxtx.java:266)
java.lang.InterruptedException: sleep interrupted
at java.lang.Thread.sleep(Native Method)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:184)
ERROR Thread\-9: could not send data: 06
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
INFO 2013-06-14 22:44:20,359 : Startup complete.
Exception in thread "Thread-11" java.lang.NullPointerException
at org.openremote.controller.statuscache.rules.RuleEngine.push(RuleEngin
e.java:145)
at org.openremote.controller.statuscache.EventProcessorChain.push(EventP
rocessorChain.java:188)
at org.openremote.controller.statuscache.StatusCache.update(StatusCache.
java:260)
at org.openremote.controller.model.sensor.Sensor.update(Sensor.java:342)

at org.openremote.controller.protocol.zwave.model.Switch.updateSensors(S
witch.java:92)
at org.openremote.controller.protocol.zwave.model.Switch.handleRequestMe
ssage(Switch.java:73)
at org.openremote.controller.protocol.zwave.model.ZWaveNode.handleZWaveR
esponseEvent(ZWaveNode.java:152)
at org.openremote.controller.protocol.zwave.ZWaveGateway.fireZWaveRespon
seEvent(ZWaveGateway.java:89)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveReader
Thread.run(ZWaveGatewayRxtx.java:266)
ERROR Thread\-9: could not send data: 06
java.io.IOException
at gnu.io.RXTXPort$SerialOutputStream.flush(RXTXPort.java:1231)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:207)
java.lang.InterruptedException: sleep interrupted
at java.lang.Thread.sleep(Native Method)
at org.openremote.controller.protocol.zwave.ZWaveGatewayRxtx$ZWaveWriter
Thread.run(ZWaveGatewayRxtx.java:184)
</code>

Posted by crossbred900 at Jun 15, 2013 03:58

use {code}...{code} with curly brackets, and no backslash in the end tag.

Posted by pz1 at Jun 15, 2013 04:09
RuntimeDroolsException: value '1.7' is not a valid language level

Are you running Java 7?

The rule engine is not liking that, you'll need to downgrade to Java 6.

Posted by juha at Jun 15, 2013 13:32

Yes I was, downgrading to Java 6 fixed the problem. Thanks again.

Posted by crossbred900 at Jun 15, 2013 18:07
Document generated by Confluence on Jun 05, 2016 09:40