I’m experiencing connection drops to myopenhab.org since a few months. It works for days and suddenly it just stops and even after waiting more than 24 hours it doesn’t automaically reconnect. I have to click on the configure button of the cloud connector in order to make it reconnect. Now I’ve just seen this in the Logs. Is this maybe related to the issue? Is this a Bug or a misconfiguration on my side? In the line before it said “Jessie request failed: null” but I wasn’t able to copy that one as it went by to fast on my console.
19:22:11.446 [INFO ] [eclipse.jetty.client.ResponseNotifier] - Exception while notifying listener org.openhab.io.openhabcloud.internal.CloudClient$ResponseListener@17f8a790
java.lang.NullPointerException: null
at org.openhab.io.openhabcloud.internal.CloudClient$ResponseListener.onComplete(CloudClient.java:588) [245:org.openhab.io.openhabcloud:2.2.0]
at org.eclipse.jetty.client.ResponseNotifier.notifyComplete(ResponseNotifier.java:193) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.ResponseNotifier.notifyComplete(ResponseNotifier.java:185) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpReceiver.terminateResponse(HttpReceiver.java:458) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpReceiver.abort(HttpReceiver.java:539) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpChannel.abortResponse(HttpChannel.java:129) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpChannel.abort(HttpChannel.java:122) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpExchange.abort(HttpExchange.java:257) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpConversation.abort(HttpConversation.java:141) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.eclipse.jetty.client.HttpRequest.abort(HttpRequest.java:735) [77:org.eclipse.jetty.client:9.3.22.v20171030]
at org.openhab.io.openhabcloud.internal.CloudClient.handleCancelEvent(CloudClient.java:403) [245:org.openhab.io.openhabcloud:2.2.0]
at org.openhab.io.openhabcloud.internal.CloudClient.onEvent(CloudClient.java:298) [245:org.openhab.io.openhabcloud:2.2.0]
at org.openhab.io.openhabcloud.internal.CloudClient$6.call(CloudClient.java:225) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.emitter.Emitter.emit(Emitter.java:117) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Socket.onevent(Socket.java:340) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Socket.onpacket(Socket.java:293) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Socket.access$100(Socket.java:19) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Socket$2$2.call(Socket.java:111) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.emitter.Emitter.emit(Emitter.java:117) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager.ondecoded(Manager.java:407) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager.access$1600(Manager.java:20) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager$7.call(Manager.java:383) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.emitter.Emitter.emit(Emitter.java:117) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.parser.Parser$Decoder.add(Parser.java:157) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager.ondata(Manager.java:399) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager.access$1000(Manager.java:20) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.client.Manager$2.call(Manager.java:350) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.emitter.Emitter.emit(Emitter.java:117) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.Socket.onPacket(Socket.java:511) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.Socket.access$1000(Socket.java:31) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.Socket$5.call(Socket.java:313) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.emitter.Emitter.emit(Emitter.java:117) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.Transport.onPacket(Transport.java:134) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.Transport.onData(Transport.java:126) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.WebSocket.access$300(WebSocket.java:28) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.WebSocket$2$3.run(WebSocket.java:122) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.thread.EventThread$2.run(EventThread.java:80) [245:org.openhab.io.openhabcloud:2.2.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
This seems to be unrelated to the issue I was having with the connection being dropped, however, this appeared today right before it went offline
2017-12-26 17:02:20.783 [ERROR] [io.openhabcloud.internal.CloudClient] - Socket.IO error: {}
io.socket.engineio.client.EngineIOException: xhr post error
at io.socket.engineio.client.Transport.onError(Transport.java:71) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.PollingXHR.access$000(PollingXHR.java:19) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.PollingXHR$4$1.run(PollingXHR.java:88) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.thread.EventThread$2.run(EventThread.java:80) [245:org.openhab.io.openhabcloud:2.2.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: java.net.SocketTimeoutException: connect timed out
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:?]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:?]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:?]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:?]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:?]
at java.net.Socket.connect(Socket.java:589) ~[?:?]
at sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:673) ~[?:?]
at sun.net.NetworkClient.doConnect(NetworkClient.java:175) ~[?:?]
at sun.net.www.http.HttpClient.openServer(HttpClient.java:463) ~[?:?]
at sun.net.www.http.HttpClient.openServer(HttpClient.java:558) ~[?:?]
at sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:264) ~[?:?]
at sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:367) ~[?:?]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:191) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1138) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1032) ~[?:?]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:177) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.getOutputStream0(HttpURLConnection.java:1316) ~[?:?]
at io.socket.engineio.client.Transport.onError(Transport.java:71) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.PollingXHR.access$000(PollingXHR.java:19) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.engineio.client.transports.PollingXHR$4$1.run(PollingXHR.java:88) [245:org.openhab.io.openhabcloud:2.2.0]
at io.socket.thread.EventThread$2.run(EventThread.java:80) [245:org.openhab.io.openhabcloud:2.2.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
Caused by: java.net.SocketTimeoutException: connect timed out
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:?]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:?]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:?]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:?]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:?]
at java.net.Socket.connect(Socket.java:589) ~[?:?]
at sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:673) ~[?:?]
at sun.net.NetworkClient.doConnect(NetworkClient.java:175) ~[?:?]
at sun.net.www.http.HttpClient.openServer(HttpClient.java:463) ~[?:?]
at sun.net.www.http.HttpClient.openServer(HttpClient.java:558) ~[?:?]
at sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:264) ~[?:?]
at sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:367) ~[?:?]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:191) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1138) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1032) ~[?:?]
at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:177) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.getOutputStream0(HttpURLConnection.java:1316) ~[?:?]
at sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:1291) ~[?:?]
at sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:250) ~[?:?]
at io.socket.engineio.client.transports.PollingXHR$Request$1.run(PollingXHR.java:206) ~[?:?]
... 1 more
2017-12-26 17:02:21.345 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = xxxxxxx, base URL = http://localhost:8080)
2017-12-26 17:02:47.789 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = xxxxxxx, base URL = http://localhost:8080)
Why is the connection not being established again, even though it says so in the logs? Is anybody else experiencing this issue? Maybe someone can investigate what requests have been received by myopenhab.org and why openhab assumes the connection is okay while myopenhab.org assumes that it isn’t.
My OH is currently showing as offline and I get a 500 error when trying to connect using the android app. However, I’m still receiving OH notifications in the app so it appears that it’s partially connected to the cloud.
Probably cause the Notifications can be pushed by a single HTTP Request to the server while incoming connections require a constant connection to be kept alive.
