openhab-cloud: Connection error recovery failed

Connection to cloud failed yesterday (22.11.2017) and remote connection didn’t work even binding claims that connection is open.

I stopped and started Cloud Connector Bundle manually 2017-11-23 17:13:XX and now remote connection works again.

All cloud related logs:

2017-11-22 16:30:14.644 [ERROR] [io.openhabcloud.internal.CloudClient] - Socket.IO error: {}
io.socket.engineio.client.EngineIOException: websocket error
	at io.socket.engineio.client.Transport.onError(Transport.java:71) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.engineio.client.transports.WebSocket.access$500(WebSocket.java:28) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.engineio.client.transports.WebSocket$2$5.run(WebSocket.java:150) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.thread.EventThread$2.run(EventThread.java:80) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	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.io.EOFException
	at okio.RealBufferedSource.require(RealBufferedSource.java:59) ~[?:?]
	at okio.RealBufferedSource.readByte(RealBufferedSource.java:72) ~[?:?]
	at okhttp3.internal.ws.WebSocketReader.readHeader(WebSocketReader.java:115) ~[?:?]
	at okhttp3.internal.ws.WebSocketReader.processNextFrame(WebSocketReader.java:104) ~[?:?]
	at okhttp3.internal.ws.RealWebSocket.readMessage(RealWebSocket.java:97) ~[?:?]
	at okhttp3.ws.WebSocketCall.createWebSocket(WebSocketCall.java:152) ~[?:?]
	at okhttp3.ws.WebSocketCall.access$000(WebSocketCall.java:41) ~[?:?]
	at okhttp3.ws.WebSocketCall$1.onResponse(WebSocketCall.java:97) ~[?:?]
	at okhttp3.RealCall$AsyncCall.execute(RealCall.java:126) ~[?:?]
	at okhttp3.internal.NamedRunnable.run(NamedRunnable.java:32) ~[?:?]
	... 3 more
2017-11-22 16:30:14.658 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)
2017-11-22 16:30:36.990 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)
2017-11-22 16:31:03.425 [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) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.engineio.client.transports.PollingXHR.access$000(PollingXHR.java:19) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.engineio.client.transports.PollingXHR$4$1.run(PollingXHR.java:88) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	at io.socket.thread.EventThread$2.run(EventThread.java:80) [244:org.openhab.io.openhabcloud:2.2.0.201710181101]
	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-11-22 16:31:03.436 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)
2017-11-22 16:31:27.842 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)
...
2017-11-23 17:13:47.544 [INFO ] [io.openhabcloud.internal.CloudClient] - Shutting down openHAB Cloud service connection
2017-11-23 17:13:47.565 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)
2017-11-23 17:13:54.207 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = ********-****-****-****-************, base URL = http://localhost:8080)

From Cloud events

Today at 5:13 PM	openhab	online
Yesterday at 4:37 PM	openhab	offline

About this issue

  • Original URL
  • State: open
  • Created 7 years ago
  • Reactions: 3
  • Comments: 26 (3 by maintainers)

Most upvoted comments

same issue on latest stable 2.4:

  • myopenhab.org shows Online status
  • my openhab item status not update. last update 07/27/2019
  • IFTTT service cannot see expose item also frequent connections / disconnections : [ERROR] [io.openhabcloud.internal.CloudClient] - Socket.IO error: {} io.socket.engineio.client.EngineIOException: websocket error at io.socket.engineio.client.Transport.onError(Transport.java:71) [232:org.openhab.io.openhabcloud:2.4.0] at io.socket.engineio.client.transports.WebSocket.access$500(WebSocket.java:28) [232:org.openhab.io.openhabcloud:2.4.0] at io.socket.engineio.client.transports.WebSocket$2$5.run(WebSocket.java:150) [232:org.openhab.io.openhabcloud:2.4.0] at io.socket.thread.EventThread$2.run(EventThread.java:80) [232:org.openhab.io.openhabcloud:2.4.0] at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:?] at java.lang.Thread.run(Unknown Source) [?:?] Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) ~[?:?] at java.net.SocketInputStream.socketRead(Unknown Source) ~[?:?] at java.net.SocketInputStream.read(Unknown Source) ~[?:?] at java.net.SocketInputStream.read(Unknown Source) ~[?:?] at sun.security.ssl.InputRecord.readFully(Unknown Source) ~[?:?] at sun.security.ssl.InputRecord.read(Unknown Source) ~[?:?] at sun.security.ssl.SSLSocketImpl.readRecord(Unknown Source) ~[?:?] at sun.security.ssl.SSLSocketImpl.readDataRecord(Unknown Source) ~[?:?] at sun.security.ssl.AppInputStream.read(Unknown Source) ~[?:?] at okio.Okio$2.read(Okio.java:138) ~[?:?] at okio.AsyncTimeout$2.read(AsyncTimeout.java:238) ~[?:?] at okio.RealBufferedSource.request(RealBufferedSource.java:66) ~[?:?] at okio.RealBufferedSource.require(RealBufferedSource.java:59) ~[?:?] at okio.RealBufferedSource.readByte(RealBufferedSource.java:72) ~[?:?] at okhttp3.internal.ws.WebSocketReader.readHeader(WebSocketReader.java:115) ~[?:?] at okhttp3.internal.ws.WebSocketReader.processNextFrame(WebSocketReader.java:104) ~[?:?] at okhttp3.internal.ws.RealWebSocket.readMessage(RealWebSocket.java:97) ~[?:?] at okhttp3.ws.WebSocketCall.createWebSocket(WebSocketCall.java:152) ~[?:?] at okhttp3.ws.WebSocketCall.access$000(WebSocketCall.java:41) ~[?:?] at okhttp3.ws.WebSocketCall$1.onResponse(WebSocketCall.java:97) ~[?:?] at okhttp3.RealCall$AsyncCall.execute(RealCall.java:126) ~[?:?] at okhttp3.internal.NamedRunnable.run(NamedRunnable.java:32) ~[?:?] ... 3 more

Unfortunately I also still ran into this issue multiple times this week. 😟