openhab-addons: [openhabcloud] No connection due to SocketIoException since 3.4.2

Expected Behavior

With openhab > 3.4.1 I want to connect to my private openhabcloud instance.

Current Behavior

When updating to 3.4.2 or higher, I can’t get a connection to my openhab cloud instance anymore. That also happens to the lates 4.0.0 M3 milestone. My openhab cloud instance runs on the latest release.

Possible Solution

Since the implementation of that fix https://github.com/openhab/openhab-addons/pull/14251 I guess I have that problem.

Steps to Reproduce (for Bugs)

As soon as I update to 3.4.2 or higher, connection to my openhabcloud instance failes

Debug logs of openhabcloud client shows the following:

2023-06-14 13:06:48.907 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : ConfigurableComponentHolder configuration updated for pid org.openhab.openhabcloud with change count 22
2023-06-14 13:06:48.909 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Querying state active
2023-06-14 13:06:48.911 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Querying state active
2023-06-14 13:06:48.912 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : getting modified: modified
2023-06-14 13:06:48.914 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Locating method modified in class org.openhab.io.openhabcloud.internal.CloudService
2023-06-14 13:06:48.916 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Declared Method org.openhab.io.openhabcloud.internal.CloudService.modified([interface org.osgi.service.component.ComponentContext]) not found
2023-06-14 13:06:48.918 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Found modified method: protected void org.openhab.io.openhabcloud.internal.CloudService.modified(java.util.Map)
2023-06-14 13:06:48.919 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : invoking modified: modified: parameters [org.apache.felix.scr.impl.helper.ReadOnlyDictionary]
2023-06-14 13:06:48.922 [DEBUG] [o.openhabcloud.internal.CloudService] - Using secret at '/var/lib/openhab/openhabcloud/secret' with content 'xx...xxx'
2023-06-14 13:06:48.923 [DEBUG] [o.openhabcloud.internal.CloudService] - UUID = xx...xxx, secret = xx...xx
2023-06-14 13:06:48.925 [INFO ] [io.openhabcloud.internal.CloudClient] - Shutting down openHAB Cloud service connection
2023-06-14 13:06:48.930 [DEBUG] [o.openhabcloud.internal.CloudService] - Using secret at '/var/lib/openhab/openhabcloud/secret' with content yy...yyy'
2023-06-14 13:06:48.939 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : invoked modified: modified
2023-06-14 13:06:48.941 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : No change in target property for dependency $000: currently registered: true
2023-06-14 13:06:48.942 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO connecting
2023-06-14 13:06:48.943 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : No change in target property for dependency $001: currently registered: true
2023-06-14 13:06:48.945 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : No change in target property for dependency $002: currently registered: true
2023-06-14 13:06:48.947 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : No change in target property for dependency osgi.ds.satisfying.condition: currently registered: true
2023-06-14 13:06:48.948 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : Querying state active
2023-06-14 13:06:48.954 [DEBUG] [ons.NotificationModuleHandlerFactory] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.actions.NotificationModuleHandlerFactory(349)] : dm $000 tracking 3 SingleStatic modified {org.openhab.io.openhabcloud.internal.CloudService, org.openhab.core.events.EventSubscriber, org.openhab.core.model.script.engine.action.ActionService}={service.id=1051, mode=remote, service.bundleid=288, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.io.openhabcloud.internal.CloudService, service.config.label=openHAB Cloud, component.id=347, service.config.factory=false, baseURL=https://<my-oh-cloud-url-with-port>, service.config.category=io, service.config.description.uri=io:openhabcloud, service.pid=[org.openhab.openhabcloud, org.openhab.openhabcloud]} (enter)
2023-06-14 13:06:48.957 [DEBUG] [ons.NotificationModuleHandlerFactory] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.actions.NotificationModuleHandlerFactory(349)] : dm $000 tracking 3 SingleStatic modified {org.openhab.io.openhabcloud.internal.CloudService, org.openhab.core.events.EventSubscriber, org.openhab.core.model.script.engine.action.ActionService}={service.id=1051, mode=remote, service.bundleid=288, service.scope=bundle, osgi.ds.satisfying.condition.target=(osgi.condition.id=true), component.name=org.openhab.io.openhabcloud.internal.CloudService, service.config.label=openHAB Cloud, component.id=347, service.config.factory=false, baseURL=https://<my-oh-cloud-url-with-port>, service.config.category=io, service.config.description.uri=io:openhabcloud, service.pid=[org.openhab.openhabcloud, org.openhab.openhabcloud]} (exit)
2023-06-14 13:06:48.958 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : ImmediateComponentHolder Finished configuring the dependency managers for component for pid org.openhab.openhabcloud
2023-06-14 13:06:48.960 [DEBUG] [o.openhabcloud.internal.CloudService] - bundle org.openhab.io.openhabcloud:4.0.0.M3 (288)[org.openhab.io.openhabcloud.internal.CloudService(347)] : ImmediateComponentHolder Will not enable component for pid org.openhab.openhabcloud: holder enabled state:true, metadata enabled: true
2023-06-14 13:06:49.212 [DEBUG] [io.openhabcloud.internal.CloudClient] - Error connecting to the openHAB Cloud instance: EngineIOException websocket error. Should reconnect automatically.
2023-06-14 13:06:51.209 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connecting (attempt 1)
2023-06-14 13:06:51.483 [DEBUG] [io.openhabcloud.internal.CloudClient] - Error connecting to the openHAB Cloud instance: EngineIOException websocket error. Should reconnect automatically.
2023-06-14 13:06:51.485 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connect attempt error: SocketIOException Connection error
2023-06-14 13:06:57.624 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connecting (attempt 2)
2023-06-14 13:06:57.889 [DEBUG] [io.openhabcloud.internal.CloudClient] - Error connecting to the openHAB Cloud instance: EngineIOException websocket error. Should reconnect automatically.
2023-06-14 13:06:57.892 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connect attempt error: SocketIOException Connection error
2023-06-14 13:07:09.414 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connecting (attempt 3)
2023-06-14 13:07:09.691 [DEBUG] [io.openhabcloud.internal.CloudClient] - Error connecting to the openHAB Cloud instance: EngineIOException websocket error. Should reconnect automatically.
2023-06-14 13:07:09.694 [DEBUG] [io.openhabcloud.internal.CloudClient] - Socket.IO re-connect attempt error: SocketIOException Connection error

Context

Your Environment

Version used: 3.4.2 and 4.0.0 M3 (installed via apt)
Environment name and version: Java 11(3.4.2) or Java 17 (4.0.0)
Operating System and version: Raspbian Buster 10.13

About this issue

Original URL
State: closed
Created a year ago
Comments: 19 (17 by maintainers)

Most upvoted comments

I finally got it working. My setup:

Apache as Reverse Proxy that forwards requests to traefik
openhabcloud as docker-compose deployment

The magic config had to be done in my virtual host in apache:

        ProxyPreserveHost On
        ProxyRequests off
        RewriteEngine On
        RewriteCond %{HTTP:Upgrade} =websocket [NC]
        RewriteRule /(.*)           ws://localhost:8081/$1 [P,L]
        ProxyPass / http://127.0.0.1:8081/
        ProxyPassReverse / http://127.0.0.1:8081/
        RequestHeader set X-Forwarded-Proto "https"
        RequestHeader set X-Forwarded-Port "8843"

andibraeu on Jun 21, 2023

try setting the logging to debug like this in your cloud config and see if that maybe shows more.

{
    "system": {
        "host": "<your-openhab-cloud-host>",
        "listenIp": "0.0.0.0",
        "port": "443",
        "protocol": "https",
        "logger" : {
            "dir": "./logs",
            "maxFiles" : "7d",
            "level" : "debug",
            "morganOption" : "dev"
          }
    },

digitaldan on Jun 19, 2023