openHAB 2 innogy SmartHome binding (BETA1)

[ollie]

Hallo Ollie,

auch von meiner Seite ein "GO". Die Variable/Zustand wird seit gestern ohne Abbrüche ausgelesen und funktioniert.
Aktuell habe ich den neusten Snapshot 2.1 drauf.

Allerdings bekomme ich beim LOG einen Error, dass ein Wert zwischen 0 - 100 liegen muss. Ich kann aber aktuell nicht nachvollziehen wie das zustande kommt. 
Dieser Fehler kommt auch andauernd. Alle "Things" sind online und funktionieren auch soweit. 

hast du eine Idee was das sein kann?

Ich nutze: 
ISD2, PSS, RST, WMD, VariableActuator

Code:

2017-05-09 15:28:05.601 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2017-05-09T13:16:42.2390000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/c0f4d472552a4fca9901a8070a14486e"},"Properties":[{"name":"MotionDetectedCount","value":111.0,"lastchanged":"2017-05-09T13:16:42.2260000Z"}]}]
2017-05-09 15:28:05.607 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/c0f4d472552a4fca9901a8070a14486e
2017-05-09 15:28:05.607 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed MotionDetectedCount to 111.0.
2017-05-09 15:28:05.608 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device Bewegung - Bewegungsmelder 1/761d9fc18a3c43219cfca8c07a8f902e
2017-05-09 15:28:05.626 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:c0f4d472552a4fca9901a8070a14486e (MotionDetectionSensor/Bewegung - Bewegungsmelder 1)
2017-05-09 15:28:05.627 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Motion state 111.0 -> count 111.0
2017-05-09 15:28:05.627 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:6f9e1c8d98bf432e9fa3defad88de616 (LuminanceSensor/Helligkeit - Bewegungsmelder 1)
2017-05-09 15:28:37.345 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2017-05-09T13:17:15.2630000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/b52001d75590440e8f09ac09c44f890b"},"Properties":[{"name":"Humidity","value":57.0,"lastchanged":"2017-05-09T13:17:15.2310000Z"},{"name":"MoldWarning","value":false,"lastchanged":"2017-04-26T18:53:46.2020000Z"}]},{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2017-05-09T13:17:15.3080000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/30785b92620a460980411056efe65dd0"},"Properties":[{"name":"Humidity","value":57.0,"lastchanged":"2017-05-09T13:17:15.2550000Z"}]}]
2017-05-09 15:28:37.346 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/b52001d75590440e8f09ac09c44f890b
2017-05-09 15:28:37.367 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed Humidity to 57.0.
2017-05-09 15:28:37.368 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed MoldWarning to false.
2017-05-09 15:28:37.368 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device Heizkörpertemperatur 6/0faea13ff8d34333a8cb008933b9185a
2017-05-09 15:28:37.416 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:ba84bd4cd0814fa4bbafbd1744ba68dd (TemperatureSensor/Temperatur (Heizkörper) 6)
2017-05-09 15:28:37.416 [DEBUG] [marthome.handler.InnogyDeviceHandler] - -> Temperature sensor state: 11.7
2017-05-09 15:28:37.418 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:f51b8c0ff278460988175c8935194ce3 (ThermostatActuator/Heizkörpertemperatur 6)
2017-05-09 15:28:37.419 [ERROR] [marthome.handler.InnogyBridgeHandler] - Error with Event: {}
java.lang.IllegalArgumentException: Value must be between 0 and 100
    at org.eclipse.smarthome.core.library.types.PercentType.validateValue(PercentType.java:51)
    at org.eclipse.smarthome.core.library.types.PercentType.<init>(PercentType.java:46)
    at org.eclipse.smarthome.core.library.types.DecimalType.as(DecimalType.java:151)
    at org.eclipse.smarthome.core.items.ItemUtil.convertToAcceptedState(ItemUtil.java:82)
    at org.eclipse.smarthome.core.thing.internal.ThingManager$1.stateUpdated(ThingManager.java:128)
    at org.eclipse.smarthome.core.thing.binding.BaseThingHandler.updateState(BaseThingHandler.java:265)
    at org.eclipse.smarthome.core.thing.binding.BaseThingHandler.updateState(BaseThingHandler.java:286)
    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.onDeviceStateChanged(InnogyDeviceHandler.java:381)
    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.onDeviceStateChanged(InnogyDeviceHandler.java:684)
    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.onEvent(InnogyBridgeHandler.java:472)
    at org.openhab.binding.innogysmarthome.internal.InnogyWebSocket.onMessage(InnogyWebSocket.java:114)
    at sun.reflect.GeneratedMethodAccessor97.invoke(Unknown Source)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_121]
    at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_121]
    at org.eclipse.jetty.websocket.common.events.annotated.CallableMethod.call(CallableMethod.java:71)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.events.annotated.OptionalSessionCallableMethod.call(OptionalSessionCallableMethod.java:72)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextMessage(JettyAnnotatedEventDriver.java:234)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.message.SimpleTextMessage.messageComplete(SimpleTextMessage.java:69)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.appendMessage(AbstractEventDriver.java:66)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextFrame(JettyAnnotatedEventDriver.java:226)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:162)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:376)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:220)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:220)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.Parser.parse(Parser.java:256)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.readParse(AbstractWebSocketConnection.java:679)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:511)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)[9:org.openhab.binding.innogysmarthome:2.1.0.201705071628]
    at java.lang.Thread.run(Thread.java:745)[:1.8.0_121]

Sehr merkwürdig. Kann ich nicht nachvollziehen. Könntest Du sicherheitshalber Deinen Snapshot mal updaten? Man weiß ja nie, ob da ein Bug drin steckt.

Ansonsten schick mir bitte nochmal eine andere Stelle aus dem Log, wo es passiert.

Hallo Ollie, 

danke für Deine schnelle Antwort. Ich habe eine ganz frische Version von OpenHAB2 (2.1.0-SNAPSHOT Build #910)
Ich habe OpenHAB2 neu gestartet und hier ist das Log (Attachment) seit diesem Zeitpunkt. 

Falls wir es nicht identifizieren können, kann ich dann irgendwie per log Befehl diese Meldung deaktivieren? Das Log wird sonst recht voll

Als Nachtrag: ich konnte bisher nicht feststellen, dass es in irgend einer Art und Weise den Funktionsumfang einschränkt. Von dem her-> Top Arbeit Ollie!!!!!

Viele Grüße
Robert

Ich raffs noch immer nicht. Hier für Dich eine Version mit zusätzlichem Debug Output:
http://www.ollie.in/wp-content/uploads/2...12-NEO.jar

Bitte installieren und dann schick mir nochmal Dein Logfile. THX!