Login

neo2211 · (Dieser Beitrag wurde zuletzt bearbeitet: 09-12-2016, 08:15:47 von neo2211.)

Hallo Ollie,

bei mir das gleiche..Hat sich aufgebaut und hat auch funktionieret. Ab gestern abend dann nix mehr (alles Online) aber schaltet nix.

2016-12-09 00:18:26.702 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"/event/Disconnect","timestamp":"2016-12-08T23:18:26.6634133Z","desc":"/desc/event/Disconnect","Properties":[{"name":"Reason","value":"SessionExpired"}]}]
2016-12-09 00:18:26.707 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"/event/Disconnect","timestamp":"2016-12-08T23:18:26.6634133Z","desc":"/desc/event/Disconnect","Properties":[{"name":"Reason","value":"SessionExpired"}]}]
2016-12-09 00:18:26.713 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:/event/Disconnect Capability:(no link)
2016-12-09 00:18:26.714 [INFO ] [marthome.handler.InnogyBridgeHandler] - Websocket disconnected. Reason: SessionExpired
2016-12-09 00:18:26.716 [INFO ] [marthome.handler.InnogyBridgeHandler] - Starting web socket.
2016-12-09 00:18:26.719 [DEBUG] [marthome.handler.InnogyBridgeHandler] - WebSocket URL: wss://api.services-smarthome.de/API/1.0/events?token=eyJ0eXAiOiJKV1QiL...boO--Y4bLw
2016-12-09 00:18:27.133 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connected to innogy WebSocket.
2016-12-09 00:18:27.213 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy Websocket session: WebSocketSession[websocket=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@378c3f],behavior=CLIENT,connection=WebSocketClientConnection@1596DC48{endp=DecryptedEndPoint@f07dc9{api.services-smarthome.de/193.25.80.79:443<->33732,Open,in,out,-,-,87/300000,WebSocketClientConnection@1596dc48}->SelectChannelEndPoint@15b43c0{api.services-smarthome.de/193.25.80.79:443<->33732,Open,in,out,-,-,67/300000,SslConnection@346657}{io=0/0,kio=0,kro=1},ios=IOState@1480cc1[CONNECTED,!in,out],f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@1acb7ee[ExtensionStack,s=START,c=0,len=0,f=null]},remote=WebSocketRemoteEndpoint@10e15cd[batching=true],incoming=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@378c3f],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]]
2016-12-09 00:18:27.248 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connection to innogy WebSocket was closed (code: 1000). Reason: null
2016-12-09 00:18:27.250 [INFO ] [marthome.handler.InnogyBridgeHandler] - Starting web socket.
2016-12-09 00:18:27.251 [DEBUG] [marthome.handler.InnogyBridgeHandler] - WebSocket URL: wss://api.services-smarthome.de/API/1.0/events?token=eyJ0eXAiOiJKV1QiL...boO--Y4bLw
2016-12-09 00:18:27.503 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connected to innogy WebSocket.
2016-12-09 00:18:27.512 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy Websocket session: WebSocketSession[websocket=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@18bc660],behavior=CLIENT,connection=WebSocketClientConnection@1596DC67{endp=DecryptedEndPoint@14c27e1{api.services-smarthome.de/193.25.80.79:443<->33733,Open,in,out,-,-,35/300000,WebSocketClientConnection@1596dc67}->SelectChannelEndPoint@173ad10{api.services-smarthome.de/193.25.80.79:443<->33733,Open,in,out,-,-,13/300000,SslConnection@712dda}{io=0/0,kio=0,kro=1},ios=IOState@1685572[CONNECTED,!in,out],f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@10b1b91[ExtensionStack,s=START,c=0,len=0,f=null]},remote=WebSocketRemoteEndpoint@1f83d8d[batching=true],incoming=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@18bc660],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]]
2016-12-09 00:19:42.448 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /fd00:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:9657:a5ff:feb5:f23b]
2016-12-09 00:19:42.450 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:9657:a5ff:feb5:f23b]
2016-12-09 00:19:42.454 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /fd00:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:9657:a5ff:feb5:f23b]
2016-12-09 00:19:42.455 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:9657:a5ff:feb5:f23b]
2016-12-09 00:21:22.708 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /fd00:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:9657:a5ff:feb5:f23b]
2016-12-09 00:21:22.710 [DEBUG] [ery.InnogyBridgeDiscoveryParticipant] - MDNS: HP Officejet Pro 6830 [B5F23A] v4:[/192.168.178.83] v6:[/fe80:0:0:0:9657:a5ff:feb5:f23b, /2a02:8109:440:390c:96

thefox73 · 09-12-2016, 08:28:16

Moin zusammen,

bei mir das gleiche Problem. Das binding hat sich irgendwann verabschiedet.
Blöderweise hab ich das DEBUG-Log nicht aktiviert....liefere ich nach.

thefox73 · 09-12-2016, 11:34:15

Hi Ollie,

ich habe eben einen Zwischenstecker eingestöpselt und es kommt dieser Fehler

Code:
10:24:13.393 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:24:06.7520000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/device/7a895f5ad58745fd9edf75cf3cf7da76"},"Properties":[{"name":"IsReachable","value":true,"lastchanged":"2016-12-09T09:24:06.7240000Z"},{"name":"DeviceConfigurationState","value":"Complete","lastchanged":"2016-12-06T16:09:33.3870000Z"},{"name":"DeviceInclusionState","value":"Included","lastchanged":"2016-12-06T16:09:32.0220000Z"},{"name":"UpdateState","value":"UpToDate","lastchanged":"0001-01-01T00:00:00.0000000Z"},{"name":"FirmwareVersion","value":"1.7","lastchanged":"2016-12-09T09:24:06.7510000Z"}]},{"type":"device/SHC.RWE/1.0/event/MessageDeleted","timestamp":"2016-12-09T09:24:07.0270000Z","desc":"/desc/device/SHC.RWE/1.0/event/MessageDeleted","link":{"value":"/message/d7cefe8f085241d0bb301e06d3a3e210"}},{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:24:07.7450000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T09:24:07.7230000Z"}]}]

10:24:13.401 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:24:06.7520000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/device/7a895f5ad58745fd9edf75cf3cf7da76"},"Properties":[{"name":"IsReachable","value":true,"lastchanged":"2016-12-09T09:24:06.7240000Z"},{"name":"DeviceConfigurationState","value":"Complete","lastchanged":"2016-12-06T16:09:33.3870000Z"},{"name":"DeviceInclusionState","value":"Included","lastchanged":"2016-12-06T16:09:32.0220000Z"},{"name":"UpdateState","value":"UpToDate","lastchanged":"0001-01-01T00:00:00.0000000Z"},{"name":"FirmwareVersion","value":"1.7","lastchanged":"2016-12-09T09:24:06.7510000Z"}]},{"type":"device/SHC.RWE/1.0/event/MessageDeleted","timestamp":"2016-12-09T09:24:07.0270000Z","desc":"/desc/device/SHC.RWE/1.0/event/MessageDeleted","link":{"value":"/message/d7cefe8f085241d0bb301e06d3a3e210"}},{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:24:07.7450000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T09:24:07.7230000Z"}]}]

10:24:13.412 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/device/7a895f5ad58745fd9edf75cf3cf7da76

10:24:13.414 [DEBUG] [home.internal.DeviceStructureManager] - getDeviceById 7a895f5ad58745fd9edf75cf3cf7da76:true

10:24:13.416 [DEBUG] [marthome.handler.InnogyBridgeHandler] - DEVICE STATE CHANGED!!!

10:24:13.417 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 7a895f5ad58745fd9edf75cf3cf7da76 relevant for this handler.

10:24:13.419 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed IsReachable to true.

10:24:13.421 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed DeviceConfigurationState to Complete.

10:24:13.422 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed DeviceInclusionState to Included.

10:24:13.424 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed UpdateState to UpToDate.

10:24:13.426 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed FirmwareVersion to 1.7.

10:24:13.427 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device Lichterkette/7a895f5ad58745fd9edf75cf3cf7da76

10:24:13.431 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:ad90047515274f47a82c6f38e460c752 (SwitchActuator/Switch)

10:24:13.433 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Capability not available for device Lichterkette (PSSO)

10:24:13.437 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/MessageDeleted Capability:/message/d7cefe8f085241d0bb301e06d3a3e210

10:24:13.439 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Unknown eventtype device/SHC.RWE/1.0/event/MessageDeleted.

10:24:13.441 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/ad90047515274f47a82c6f38e460c752

10:24:13.444 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 7a895f5ad58745fd9edf75cf3cf7da76 relevant for this handler.

10:24:13.446 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to false.

10:24:13.449 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id ad90047515274f47a82c6f38e460c752, device /device/7a895f5ad58745fd9edf75cf3cf7da76 from device id 7a895f5ad58745fd9edf75cf3cf7da76

10:24:13.452 [ERROR] [marthome.handler.InnogyBridgeHandler] - Error with Event: {}

java.lang.NullPointerException

        at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.onDeviceStateChanged(InnogyDeviceHandler.java:321)

        at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.onEvent(InnogyBridgeHandler.java:452)

        at org.openhab.binding.innogysmarthome.internal.InnogyWebSocket.onMessage(InnogyWebSocket.java:63)

        at sun.reflect.GeneratedMethodAccessor40.invoke(Unknown Source)

        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_111]

        at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_111]

        at org.eclipse.jetty.websocket.common.events.annotated.CallableMethod.call(CallableMethod.java:71)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.annotated.OptionalSessionCallableMethod.call(OptionalSessionCallableMethod.java:72)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextMessage(JettyAnnotatedEventDriver.java:234)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.message.SimpleTextMessage.messageComplete(SimpleTextMessage.java:69)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.appendMessage(AbstractEventDriver.java:66)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextFrame(JettyAnnotatedEventDriver.java:226)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:162)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:376)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.parse(Parser.java:256)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.readParse(AbstractWebSocketConnection.java:679)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:511)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at java.lang.Thread.run(Thread.java:745)[:1.8.0_111]

10:26:42.684 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connection to innogy WebSocket was closed (code: 1000). Reason: null

10:26:42.687 [INFO ] [marthome.handler.InnogyBridgeHandler] - Starting web socket.

10:26:42.688 [DEBUG] [marthome.handler.InnogyBridgeHandler] - WebSocket URL: wss://api.services-smarthome.de/API/1.0/events?token=blablubbbb

10:26:42.990 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connected to innogy WebSocket.

10:26:42.996 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy Websocket session: WebSocketSession[websocket=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@13619f0],behavior=CLIENT,connection=WebSocketClientConnection@158E2A94{endp=DecryptedEndPoint@1f1e5a6{api.services-smarthome.de/193.25.80.79:443<->60634,Open,in,out,-,-,60/300000,WebSocketClientConnection@158e2a94}->SelectChannelEndPoint@1ce7280{api.services-smarthome.de/193.25.80.79:443<->60634,Open,in,out,-,-,9/300000,SslConnection@ccef9d}{io=0/0,kio=0,kro=1},ios=IOState@194942d[CONNECTED,!in,out],f=Flusher[queueSize=0,aggregateSize=0,failure=null],g=Generator[CLIENT,validating],p=Parser@15892ac[ExtensionStack,s=START,c=0,len=0,f=null]},remote=WebSocketRemoteEndpoint@1eab7b5[batching=true],incoming=JettyAnnotatedEventDriver[org.openhab.binding.innogysmarthome.internal.InnogyWebSocket@13619f0],outgoing=ExtensionStack[queueSize=0,extensions=[],incoming=org.eclipse.jetty.websocket.common.WebSocketSession,outgoing=org.eclipse.jetty.websocket.client.io.WebSocketClientConnection]]

Danach berappelt sich das binding aber scheinbar wieder und läuft.

thefox73 · 09-12-2016, 12:08:25

Hi Ollie,

schalte ich genau den im vorigen Post erwähnten Außenzwischenstecker, dann passiert folgendes

Code:
10:59:07.535 [DEBUG] [marthome.handler.InnogyDeviceHandler] - handleCommand called for channel 'innogysmarthome:PSSO:SMARTHOME06:7a895f5ad58745fd9edf75cf3cf7da76:switch' of type 'PSSO' with command 'ON'

10:59:07.537 [DEBUG] [home.internal.DeviceStructureManager] - getDeviceById 7a895f5ad58745fd9edf75cf3cf7da76:true

10:59:08.306 [INFO ] [marthome.event.ItemStateChangedEvent] - zbv3_outdoor changed from OFF to ON

10:59:11.216 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:59:04.4130000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T09:59:04.3960000Z"}]}]

10:59:11.217 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:59:04.4130000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T09:59:04.3960000Z"}]}]

10:59:11.229 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/ad90047515274f47a82c6f38e460c752

10:59:11.231 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 7a895f5ad58745fd9edf75cf3cf7da76 relevant for this handler.

10:59:11.233 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to true.

10:59:11.234 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id ad90047515274f47a82c6f38e460c752, device /device/7a895f5ad58745fd9edf75cf3cf7da76 from device id 7a895f5ad58745fd9edf75cf3cf7da76

10:59:11.236 [ERROR] [marthome.handler.InnogyBridgeHandler] - Error with Event: {}

java.lang.NullPointerException

        at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.onDeviceStateChanged(InnogyDeviceHandler.java:321)

        at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.onEvent(InnogyBridgeHandler.java:452)

        at org.openhab.binding.innogysmarthome.internal.InnogyWebSocket.onMessage(InnogyWebSocket.java:63)

        at sun.reflect.GeneratedMethodAccessor40.invoke(Unknown Source)

        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_111]

        at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_111]

        at org.eclipse.jetty.websocket.common.events.annotated.CallableMethod.call(CallableMethod.java:71)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.annotated.OptionalSessionCallableMethod.call(OptionalSessionCallableMethod.java:72)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextMessage(JettyAnnotatedEventDriver.java:234)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.message.SimpleTextMessage.messageComplete(SimpleTextMessage.java:69)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.appendMessage(AbstractEventDriver.java:66)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextFrame(JettyAnnotatedEventDriver.java:226)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:162)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:376)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.parse(Parser.java:256)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.readParse(AbstractWebSocketConnection.java:679)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:511)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at java.lang.Thread.run(Thread.java:745)[:1.8.0_111]

10:59:11.602 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:59:04.4130000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T09:59:04.3960000Z"}]}]

10:59:11.603 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T09:59:04.4130000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/ad90047515274f47a82c6f38e460c752"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T09:59:04.3960000Z"}]}]

10:59:11.606 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/ad90047515274f47a82c6f38e460c752

10:59:11.607 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 7a895f5ad58745fd9edf75cf3cf7da76 relevant for this handler.

10:59:11.608 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to true.

10:59:11.608 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id ad90047515274f47a82c6f38e460c752, device /device/7a895f5ad58745fd9edf75cf3cf7da76 from device id 7a895f5ad58745fd9edf75cf3cf7da76

10:59:11.609 [ERROR] [marthome.handler.InnogyBridgeHandler] - Error with Event: {}

java.lang.NullPointerException

        at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.onDeviceStateChanged(InnogyDeviceHandler.java:321)

        at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.onEvent(InnogyBridgeHandler.java:452)

        at org.openhab.binding.innogysmarthome.internal.InnogyWebSocket.onMessage(InnogyWebSocket.java:63)

        at sun.reflect.GeneratedMethodAccessor40.invoke(Unknown Source)

        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)[:1.8.0_111]

        at java.lang.reflect.Method.invoke(Method.java:498)[:1.8.0_111]

        at org.eclipse.jetty.websocket.common.events.annotated.CallableMethod.call(CallableMethod.java:71)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.annotated.OptionalSessionCallableMethod.call(OptionalSessionCallableMethod.java:72)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextMessage(JettyAnnotatedEventDriver.java:234)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.message.SimpleTextMessage.messageComplete(SimpleTextMessage.java:69)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.appendMessage(AbstractEventDriver.java:66)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.JettyAnnotatedEventDriver.onTextFrame(JettyAnnotatedEventDriver.java:226)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:162)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:376)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:220)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.Parser.parse(Parser.java:256)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.readParse(AbstractWebSocketConnection.java:679)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:511)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)[210:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

        at java.lang.Thread.run(Thread.java:745)[:1.8.0_111]

Schalte ich andere Zwischenstecker, passiert der Fehler nicht.

thefox73 · 09-12-2016, 12:36:57

Hier steigt das binding dann irgemdwo aus.
Schaltvorgänge, die ich nach diesem Fehler per PaperUI auslöse funktionieren und werden in der Konsole angezeigt.
Alles was ich per innogy UI schalte, kommt in OH nicht mehr an

Code:
06:26.277 [INFO ] [marthome.event.ItemStateChangedEvent] - zbv2 changed from OFF to ON

06:26.565 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:20.9650000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T10:06:20.9470000Z"}]}]

06:26.566 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:20.9650000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":true,"lastchanged":"2016-12-09T10:06:20.9470000Z"}]}]

06:26.571 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/dc4e8455301d4e2cb4cc8d242559bfdb

06:26.572 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 17e37eeba7d645f0afb2c6062adb9adc relevant for this handler.

06:26.573 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to true.

06:26.574 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id dc4e8455301d4e2cb4cc8d242559bfdb, device /device/17e37eeba7d645f0afb2c6062adb9adc from device id 17e37eeba7d645f0afb2c6062adb9adc

06:26.575 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device ZBV2/17e37eeba7d645f0afb2c6062adb9adc

06:26.577 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:dc4e8455301d4e2cb4cc8d242559bfdb (SwitchActuator/Switch)

06:31.667 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:25.7970000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T10:06:25.7800000Z"}]}]

06:31.677 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:25.7970000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T10:06:25.7800000Z"}]}]

06:31.685 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/dc4e8455301d4e2cb4cc8d242559bfdb

06:31.687 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 17e37eeba7d645f0afb2c6062adb9adc relevant for this handler.

06:31.689 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to false.

06:31.691 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id dc4e8455301d4e2cb4cc8d242559bfdb, device /device/17e37eeba7d645f0afb2c6062adb9adc from device id 17e37eeba7d645f0afb2c6062adb9adc

06:31.693 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device ZBV2/17e37eeba7d645f0afb2c6062adb9adc

06:31.697 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:dc4e8455301d4e2cb4cc8d242559bfdb (SwitchActuator/Switch)

06:31.707 [INFO ] [marthome.event.ItemStateChangedEvent] - zbv2 changed from ON to OFF

06:32.008 [DEBUG] [gysmarthome.internal.InnogyWebSocket] - innogy WebSocket onMessage() - [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:25.7970000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T10:06:25.7800000Z"}]}]

06:32.009 [DEBUG] [marthome.handler.InnogyBridgeHandler] - onEvent called. Msg: [{"type":"device/SHC.RWE/1.0/event/StateChanged","timestamp":"2016-12-09T10:06:25.7970000Z","desc":"/desc/device/SHC.RWE/1.0/event/StateChanged","link":{"value":"/capability/dc4e8455301d4e2cb4cc8d242559bfdb"},"Properties":[{"name":"OnState","value":false,"lastchanged":"2016-12-09T10:06:25.7800000Z"}]}]

06:32.018 [DEBUG] [marthome.handler.InnogyBridgeHandler] - Event found: Type:device/SHC.RWE/1.0/event/StateChanged Capability:/capability/dc4e8455301d4e2cb4cc8d242559bfdb

06:32.020 [DEBUG] [marthome.handler.InnogyDeviceHandler] - DeviceId 17e37eeba7d645f0afb2c6062adb9adc relevant for this handler.

06:32.021 [DEBUG] [marthome.handler.InnogyDeviceHandler] - State changed OnState to false.

06:32.023 [DEBUG] [marthome.handler.InnogyDeviceHandler] - Loaded Capability SwitchActuator, Switch with id dc4e8455301d4e2cb4cc8d242559bfdb, device /device/17e37eeba7d645f0afb2c6062adb9adc from device id 17e37eeba7d645f0afb2c6062adb9adc

06:32.025 [DEBUG] [marthome.handler.InnogyDeviceHandler] - onDeviceStateChanged called with device ZBV2/17e37eeba7d645f0afb2c6062adb9adc

06:32.028 [DEBUG] [marthome.handler.InnogyDeviceHandler] - ->capability:dc4e8455301d4e2cb4cc8d242559bfdb (SwitchActuator/Switch)

sboldt · 09-12-2016, 13:57:21

Hi Ollie,

ich habe nun auch das Problem, dass das Binding nach ein paar Stunden nicht mehr funktioniert, allerdings scheinbar ohne Fehlermeldung, es kommen einfach keine Werte mehr von den RSTs. Erst als ich einen Zwischenschalter über OH schalten wollte warf das Binding den Fehler "Unexcepted API error: Session not found" und ging samt sämtlicher Geräte OFFLINE. Zwei Minuten später ging dann alles wieder ONLINE, ließ sich allerdings immer noch nicht schalten (java.lang.NullPointerException). Wiederum kurz darauf kommen die Meldungen "Starting web socket." und "Connected to innogy WebSocket.". Als ich ca. 30 Minuten später nochmal probierte einen Zwischenstecker zu schalten klappte dies wieder problemlos.

Hier die Logs:

Code:
04:28:42.101 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadCurrentTemp changed from 15.800000000000000710542735760100185871124267578125 to 15.699999999999999289457264239899814128875732421875

04:31:33.700 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 75 to 75.5

04:36:55.128 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWCurrentTemp changed from 15.699999999999999289457264239899814128875732421875 to 15.5999999999999996447286321199499070644378662109375

04:38:17.670 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 18.60000000000000142108547152020037174224853515625 to 18.5

04:39:05.585 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZCurrentTemp changed from 12.9000000000000003552713678800500929355621337890625 to 13

04:48:52.380 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadCurrentTemp changed from 15.699999999999999289457264239899814128875732421875 to 15.5999999999999996447286321199499070644378662109375

04:50:22.667 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZHumidity changed from 43.5 to 44

04:51:08.150 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 75.5 to 76

04:55:28.026 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 18.5 to 18.39999999999999857891452847979962825775146484375

04:57:53.576 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWHumidity changed from 66.5 to 67

11:59:39.679 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

11:59:39.818 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unexcepted API error: Session not found

11:59:39.854 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

11:59:39.854 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 180 seconds.

11:59:39.856 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:bridge:SMARTHOME09' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Session not found

11:59:39.858 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:56e88db99dcc4ce8ac3ce3694449bc69' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.860 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:17d65ecf38a141c58192803e72fc2e5e' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.860 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:5bfa78c42d884286a07d7a0803978ad4' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.860 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:bd7ada6efe9b443b96ac87d36f877273' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.862 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:6f417e8ad5a243e9a7751377d85ed811' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.863 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

11:59:39.865 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:b02f0cf908c2402abb593f49878a2c18' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.865 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:ce60af058193431e92fbb852dcb84a99' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.865 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:e20d69ab8dab40a482796eabe91983dc' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:39.866 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:a630fcb0db7d4366813b5799bae09841' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

11:59:42.911 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

11:59:42.915 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

11:59:42.918 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

11:59:42.919 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

11:59:42.921 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

11:59:44.851 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

11:59:44.853 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

11:59:44.855 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

11:59:44.856 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

11:59:44.856 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

11:59:46.032 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

11:59:46.033 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

11:59:46.034 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

11:59:46.034 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

11:59:46.034 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:00:07.077 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

12:00:07.078 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:00:07.078 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:00:07.079 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:00:07.087 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

12:00:09.033 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

12:00:09.034 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:00:09.035 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:00:09.035 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:00:09.036 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

12:00:31.599 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

12:00:31.601 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:00:31.602 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:00:31.602 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:00:31.605 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

12:00:34.597 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

12:00:34.598 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:00:34.599 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:00:34.599 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:00:34.602 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

12:01:04.600 [INFO ] [marthome.handler.InnogyBridgeHandler] - Initializing innogy SmartHome client...

12:01:04.789 [INFO ] [marthome.handler.InnogyBridgeHandler] - Session already exists. Continuing...

12:01:04.797 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'innogysmarthome:bridge:SMARTHOME09' has been updated.

12:01:07.216 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:01:07.217 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:01:07.217 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:01:07.218 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:01:07.218 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:01:07.219 [INFO ] [home.internal.DeviceStructureManager] - Devices loaded. Device structure manager ready.

12:01:07.220 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:bridge:SMARTHOME09' changed from OFFLINE (COMMUNICATION_ERROR): Session not found to ONLINE

12:01:07.236 [WARN ] [marthome.handler.InnogyDeviceHandler] - initializeProperties: device is null

12:01:07.238 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:56e88db99dcc4ce8ac3ce3694449bc69' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.238 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:17d65ecf38a141c58192803e72fc2e5e' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.239 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:bd7ada6efe9b443b96ac87d36f877273' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.241 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZHumidity changed from 44 to 37.5

12:01:07.245 [WARN ] [marthome.handler.InnogyDeviceHandler] - initializeProperties: device is null

12:01:07.247 [INFO ] [marthome.handler.InnogyBridgeHandler] - Starting web socket.

12:01:07.249 [WARN ] [marthome.handler.InnogyDeviceHandler] - initializeProperties: device is null

12:01:07.250 [WARN ] [marthome.handler.InnogyDeviceHandler] - initializeProperties: device is null

12:01:07.256 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:5bfa78c42d884286a07d7a0803978ad4' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.258 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:a630fcb0db7d4366813b5799bae09841' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.259 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:PSS:SMARTHOME09:e20d69ab8dab40a482796eabe91983dc' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.259 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:6f417e8ad5a243e9a7751377d85ed811' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.260 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:b02f0cf908c2402abb593f49878a2c18' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.260 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'innogysmarthome:RST:SMARTHOME09:ce60af058193431e92fbb852dcb84a99' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE

12:01:07.261 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 18.39999999999999857891452847979962825775146484375 to 22.300000000000000710542735760100185871124267578125

12:01:07.261 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZTargetTemperature changed from 12.5 to 22

12:01:07.390 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connected to innogy WebSocket.

12:03:23.046 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZHumidity changed from 37.5 to 38

12:10:35.885 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.300000000000000710542735760100185871124267578125 to 22.39999999999999857891452847979962825775146484375

12:15:37.732 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.39999999999999857891452847979962825775146484375 to 22.5

12:17:46.639 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.5 to 22.60000000000000142108547152020037174224853515625

12:20:45.342 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.60000000000000142108547152020037174224853515625 to 22.699999999999999289457264239899814128875732421875

12:23:29.836 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.699999999999999289457264239899814128875732421875 to 22.800000000000000710542735760100185871124267578125

12:26:24.457 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.800000000000000710542735760100185871124267578125 to 22.89999999999999857891452847979962825775146484375

12:28:15.775 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 22.89999999999999857891452847979962825775146484375 to 23

12:30:16.974 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 23 to 23.10000000000000142108547152020037174224853515625

12:32:00.937 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

12:32:00.939 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:32:00.944 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

12:32:01.425 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:32:01.425 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:32:03.034 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

12:32:03.036 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unknown exception

java.lang.NullPointerException

    at org.openhab.binding.innogysmarthome.handler.InnogyBridgeHandler.commandSwitchDevice(InnogyBridgeHandler.java:539)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.openhab.binding.innogysmarthome.handler.InnogyDeviceHandler.handleCommand(InnogyDeviceHandler.java:76)[194:org.openhab.binding.innogysmarthome:2.0.0.201612072035]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:355)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.thing.internal.ThingManager$3.call(ThingManager.java:1)[103:org.eclipse.smarthome.core.thing:0.9.0.201612010841]

    at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[96:org.eclipse.smarthome.core:0.9.0.201612010841]

    at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_112]

    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_112]

    at java.lang.Thread.run(Thread.java:745)[:1.8.0_112]

12:32:03.038 [INFO ] [marthome.handler.InnogyBridgeHandler] - innogy SmartHome bridge handler shut down.

12:32:03.038 [INFO ] [marthome.handler.InnogyBridgeHandler] - Scheduling reinitialize in 30 seconds.

12:32:03.039 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

12:32:33.039 [INFO ] [marthome.handler.InnogyBridgeHandler] - Initializing innogy SmartHome client...

12:32:33.962 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'innogysmarthome:bridge:SMARTHOME09' has been updated.

12:32:39.885 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:32:39.886 [WARN ] [home.internal.DeviceStructureManager] - NPEX.

12:32:39.888 [INFO ] [home.internal.DeviceStructureManager] - Devices loaded. Device structure manager ready.

12:32:39.889 [INFO ] [marthome.handler.InnogyBridgeHandler] - Starting web socket.

12:32:39.993 [INFO ] [gysmarthome.internal.InnogyWebSocket] - Connected to innogy WebSocket.

12:33:07.400 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 23.10000000000000142108547152020037174224853515625 to 23.199999999999999289457264239899814128875732421875

12:33:09.953 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadHumidity changed from 66 to 55.5

12:33:09.962 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadCurrentTemp changed from 15.5999999999999996447286321199499070644378662109375 to 20.39999999999999857891452847979962825775146484375

12:33:09.967 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadHumidity changed from 55.5 to 56

12:34:34.840 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 76 to 75.5

12:34:34.843 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZCurrentTemp changed from 13 to 12.800000000000000710542735760100185871124267578125

12:34:34.847 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 75.5 to 75

12:35:53.135 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadHumidity changed from 56 to 56.5

12:36:01.490 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWTargetTemperature changed from 13.5 to 21

12:36:01.494 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWCurrentTemp changed from 15.5999999999999996447286321199499070644378662109375 to 21.60000000000000142108547152020037174224853515625

12:36:01.496 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWHumidity changed from 67 to 56

12:36:01.502 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWHumidity changed from 56 to 56.5

12:36:57.879 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZCurrentTemp changed from 12.800000000000000710542735760100185871124267578125 to 12.699999999999999289457264239899814128875732421875

12:36:58.469 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 75 to 74.5

12:38:05.775 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 23.199999999999999289457264239899814128875732421875 to 23.300000000000000710542735760100185871124267578125

12:38:05.786 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZHumidity changed from 38 to 37.5

12:38:15.337 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungHWHumidity changed from 56.5 to 57

12:38:21.469 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadCurrentTemp changed from 20.39999999999999857891452847979962825775146484375 to 20.300000000000000710542735760100185871124267578125

12:39:06.242 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZCurrentTemp changed from 12.699999999999999289457264239899814128875732421875 to 12.5999999999999996447286321199499070644378662109375

12:39:06.247 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZHumidity changed from 74.5 to 74

12:42:04.255 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungSZCurrentTemp changed from 12.5999999999999996447286321199499070644378662109375 to 12.5

12:42:24.006 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command ON

12:42:24.479 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from OFF to ON

12:42:25.856 [INFO ] [smarthome.event.ItemCommandEvent    ] - Item 'Switch_test' received command OFF

12:42:26.272 [INFO ] [marthome.event.ItemStateChangedEvent] - Switch_test changed from ON to OFF

12:42:36.006 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungBadCurrentTemp changed from 20.300000000000000710542735760100185871124267578125 to 20.199999999999999289457264239899814128875732421875

12:43:10.043 [INFO ] [marthome.event.ItemStateChangedEvent] - HeizungWZCurrentTemp changed from 23.300000000000000710542735760100185871124267578125 to 23.39999999999999857891452847979962825775146484375

thefox73 · 09-12-2016, 14:08:45

Mal ne andere Frage:
Nutzt jemand von Euch das HUE-binding in OH2 und gleichzeitig das HUE addin in innogy SH?
Funktioniert das bei Euch?

bezibaerchen · 09-12-2016, 14:28:17

Ja, aber beide haben in meinen Augen so ihre Krankheiten. Aber wenns geht, dann geht es. Ich persönlich bin mit dem Binding von OH 1.8 besser zurecht gekommen.

Gubbo · (Dieser Beitrag wurde zuletzt bearbeitet: 09-12-2016, 14:35:45 von Gubbo.)

(09-12-2016, 13:57:21)sboldt schrieb: Hi Ollie,

ich habe nun auch das Problem, dass das Binding nach ein paar Stunden nicht mehr funktioniert, allerdings scheinbar ohne Fehlermeldung, es kommen einfach keine Werte mehr von den RSTs. Erst als ich einen Zwischenschalter über OH schalten wollte warf das Binding den Fehler "Unexcepted API error: Session not found" und ging samt sämtlicher Geräte OFFLINE. Zwei Minuten später ging dann alles wieder ONLINE, ließ sich allerdings immer noch nicht schalten (java.lang.NullPointerException). Wiederum kurz darauf kommen die Meldungen "Starting web socket." und "Connected to innogy WebSocket.". Als ich ca. 30 Minuten später nochmal probierte einen Zwischenstecker zu schalten klappte dies wieder problemlos.

Hier die Logs: ...

Mal probiert OpenHAB im DEBUG-Modus zu starten? Eventuell bekommst du dann aus den Logs mehr raus...

thefox73 · 09-12-2016, 14:35:52

Hi Ollie,

während des Startvorgangs von OH kommt (häufiger) dieser Fehler

Code:
13:33:09.606 [ERROR] [marthome.handler.InnogyBridgeHandler] - Unexcepted API error: Invalid JSON syntax in error response: java.lang.IllegalStateException: Expected BEGIN_OBJECT but was STRING at line 1 column 2 path $

Evtl. ein hinweis für Dich?

Login
Benutzername/E-Mail:
Passwort:	Passwort vergessen?
	Merken