Problem connecting to myopenhab.org cloud Socket.IO error

Apps & Services openHAB Cloud
,
1

Hi!

I’m installing OH2 snapshot from today in one clean installation of Lubuntu.

On first launch I installed the expert package, and on paper UI added the cloud connector.

With the newly generated UUID and secret I had updated this key on my account on myopenhab.org account.

After restarting the openhab several times, on cloud i’m unable to establish one connection.

Here is my log:

2017-01-15 12:18:36.899 [DEBUG] [org.openhab.io.jetty.certificate    ] - BundleEvent STARTING - org.openhab.io.jetty.certificate
2017-01-15 12:18:36.987 [DEBUG] [ficate.internal.CertificateGenerator] - Keystore found. Trying to load /var/lib/openhab2/etc/keystore
2017-01-15 12:18:37.004 [DEBUG] [ficate.internal.CertificateGenerator] - mykey alias found. Do nothing.
2017-01-15 12:18:37.007 [DEBUG] [org.openhab.io.jetty.certificate    ] - BundleEvent STARTED - org.openhab.io.jetty.certificate
2017-01-15 12:19:16.309 [DEBUG] [org.openhab.core.karaf              ] - ServiceEvent REGISTERED - {org.openhab.core.karaf.internal.FeatureInstaller, org.osgi.service.cm.ConfigurationListener}={misc=restdocs,myopenhab, component.name=org.openhab.addons, remote=true, service.config.category=system, service.config.description.uri=system:addons, felix.fileinstall.filename=file:/var/lib/openhab2/etc/org.openhab.addons.cfg, service.pid=org.openhab.addons, service.config.label=Add-on Management, transformation=map,regex,xslt,exec,javascript,scale,xpath,jsonpath, ui=classic,basic,paper,habpanel,habmin, component.id=134, package=expert, service.id=262, service.bundleid=167, service.scope=bundle} - org.openhab.core.karaf
2017-01-15 12:19:16.397 [DEBUG] [org.openhab.core.karaf              ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.extension.ExtensionService}={component.name=org.openhab.core.karafextension, component.id=135, service.id=263, service.bundleid=167, service.scope=bundle} - org.openhab.core.karaf
2017-01-15 12:19:16.421 [DEBUG] [org.openhab.core.karaf              ] - BundleEvent STARTING - org.openhab.core.karaf
2017-01-15 12:19:16.508 [DEBUG] [org.openhab.core.karaf              ] - BundleEvent STARTED - org.openhab.core.karaf
2017-01-15 12:19:17.047 [DEBUG] [org.openhab.ui.dashboard            ] - ServiceEvent REGISTERED - {javax.servlet.ServletContext}={osgi.web.symbolicname=org.openhab.ui.dashboard, osgi.web.version=2.0.0.201701141030, osgi.web.contextpath=/, service.id=264, service.bundleid=170, service.scope=singleton} - org.openhab.ui.dashboard
2017-01-15 12:19:17.187 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start
2017-01-15 12:19:17.189 [DEBUG] [org.openhab.ui.dashboard            ] - BundleEvent STARTING - org.openhab.ui.dashboard
2017-01-15 12:19:17.193 [DEBUG] [org.openhab.ui.dashboard            ] - BundleEvent STARTED - org.openhab.ui.dashboard
2017-01-15 12:19:17.247 [DEBUG] [org.openhab.core.compat1x           ] - BundleEvent STARTING - org.openhab.core.compat1x
2017-01-15 12:19:17.432 [DEBUG] [org.openhab.core.compat1x           ] - ServiceEvent REGISTERED - {org.openhab.core.events.EventPublisher}={component.name=org.openhab.core.compat1x.eventpublisherdelegate, component.id=137, service.id=265, service.bundleid=176, service.scope=bundle} - org.openhab.core.compat1x
2017-01-15 12:19:17.709 [DEBUG] [org.openhab.core.compat1x           ] - ServiceEvent REGISTERED - {org.osgi.service.event.EventHandler, org.eclipse.smarthome.core.events.EventSubscriber}={event.topics=smarthome/*, component.name=org.openhab.core.compat1x.eventbridge, component.id=139, service.id=266, service.bundleid=176, service.scope=bundle} - org.openhab.core.compat1x
2017-01-15 12:19:17.798 [DEBUG] [org.openhab.core.compat1x           ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.autoupdate.AutoUpdateBindingConfigProvider}={component.name=org.openhab.core.compat1x.autoupdateproviderdelegate, component.id=143, service.id=267, service.bundleid=176, service.scope=bundle} - org.openhab.core.compat1x
2017-01-15 12:19:18.032 [DEBUG] [org.openhab.core.compat1x           ] - ServiceEvent REGISTERED - {org.openhab.core.items.ItemRegistry, org.openhab.ui.items.ItemUIRegistry}={component.name=org.openhab.core.compat1x.itemuiregistry, component.id=144, service.id=268, service.bundleid=176, service.scope=bundle} - org.openhab.core.compat1x
2017-01-15 12:19:18.036 [DEBUG] [org.openhab.core.compat1x           ] - BundleEvent STARTED - org.openhab.core.compat1x
2017-01-15 12:19:20.511 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app
2017-01-15 12:19:21.275 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
2017-01-15 12:19:22.246 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2017-01-15 12:19:22.274 [DEBUG] [org.openhab.io.rest.docs            ] - BundleEvent STARTING - org.openhab.io.rest.docs
2017-01-15 12:19:22.492 [DEBUG] [org.openhab.io.rest.docs            ] - ServiceEvent REGISTERED - {javax.servlet.ServletContext}={osgi.web.symbolicname=org.openhab.io.rest.docs, osgi.web.version=2.0.0.201701141030, osgi.web.contextpath=/, service.id=310, service.bundleid=200, service.scope=singleton} - org.openhab.io.rest.docs
2017-01-15 12:19:22.498 [DEBUG] [org.openhab.io.rest.docs            ] - ServiceEvent REGISTERED - {org.openhab.ui.dashboard.DashboardTile}={component.name=org.openhab.io.rest.docs.dashboardtile, component.id=182, service.id=309, service.bundleid=200, service.scope=bundle} - org.openhab.io.rest.docs
2017-01-15 12:19:22.508 [DEBUG] [org.openhab.io.rest.docs            ] - BundleEvent STARTED - org.openhab.io.rest.docs
2017-01-15 12:19:22.512 [DEBUG] [org.openhab.ui.classicui            ] - BundleEvent STARTING - org.openhab.ui.classicui
2017-01-15 12:19:22.546 [DEBUG] [org.openhab.ui.classicui            ] - ServiceEvent REGISTERED - {org.openhab.ui.dashboard.DashboardTile}={component.name=org.openhab.ui.classicui.dashboardtile, component.id=183, service.id=311, service.bundleid=202, service.scope=bundle} - org.openhab.ui.classicui
2017-01-15 12:19:22.552 [DEBUG] [org.openhab.ui.classicui            ] - BundleEvent STARTED - org.openhab.ui.classicui
2017-01-15 12:19:22.564 [DEBUG] [org.openhab.ui.habmin               ] - BundleEvent STARTING - org.openhab.ui.habmin
2017-01-15 12:19:22.733 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.io.rest.RESTResource}={component.name=org.openhab.ui.habmin.floorplan, component.id=184, service.id=312, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:22.743 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.openhab.ui.dashboard.DashboardTile}={component.name=org.openhab.ui.habmin.dashboardtile, component.id=185, service.id=313, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:22.797 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.io.rest.RESTResource}={component.name=org.openhab.ui.habmin.designer, component.id=186, service.id=314, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:22.994 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {javax.servlet.ServletContext}={osgi.web.symbolicname=org.openhab.ui.habmin, osgi.web.version=2.0.0.201701141030, osgi.web.contextpath=/, service.id=315, service.bundleid=203, service.scope=singleton} - org.openhab.ui.habmin
2017-01-15 12:19:23.018 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2017-01-15 12:19:23.072 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.io.rest.RESTResource}={component.name=org.openhab.ui.habmin.rules, component.id=188, service.id=316, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:23.142 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.io.rest.RESTResource}={component.name=org.openhab.ui.habmin.dashboard, component.id=189, service.id=317, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:23.187 [DEBUG] [org.openhab.ui.habmin               ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.io.rest.RESTResource}={component.name=org.openhab.ui.habmin.charts, component.id=190, service.id=318, service.bundleid=203, service.scope=bundle} - org.openhab.ui.habmin
2017-01-15 12:19:23.200 [DEBUG] [org.openhab.ui.habmin               ] - BundleEvent STARTED - org.openhab.ui.habmin
2017-01-15 12:19:23.208 [DEBUG] [org.openhab.ui.habpanel             ] - BundleEvent STARTING - org.openhab.ui.habpanel
2017-01-15 12:19:23.490 [DEBUG] [org.openhab.ui.habpanel             ] - ServiceEvent REGISTERED - {javax.servlet.ServletContext}={osgi.web.symbolicname=org.openhab.ui.habpanel, osgi.web.version=2.0.0.201701141030, osgi.web.contextpath=/, service.id=320, service.bundleid=204, service.scope=singleton} - org.openhab.ui.habpanel
2017-01-15 12:19:23.493 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2017-01-15 12:19:23.496 [DEBUG] [org.openhab.ui.habpanel             ] - ServiceEvent REGISTERED - {org.openhab.ui.dashboard.DashboardTile}={service.config.category=ui, service.config.label=HABPanel, component.name=org.openhab.ui.habpanel, component.id=191, service.config.description.uri=ui:habpanel, service.id=319, service.bundleid=204, service.scope=bundle} - org.openhab.ui.habpanel
2017-01-15 12:19:23.497 [DEBUG] [org.openhab.ui.habpanel             ] - BundleEvent STARTED - org.openhab.ui.habpanel
2017-01-15 12:19:23.580 [DEBUG] [org.openhab.io.myopenhab            ] - BundleEvent STARTING - org.openhab.io.myopenhab
2017-01-15 12:19:23.677 [DEBUG] [.myopenhab.internal.MyOpenHABService] - my.openHAB service activated
2017-01-15 12:19:23.778 [DEBUG] [.myopenhab.internal.MyOpenHABService] - Using secret at '/var/lib/openhab2/myopenhab/secret' with content 'PZcpaw3skipCl441kh3W'
2017-01-15 12:19:23.820 [DEBUG] [.myopenhab.internal.MyOpenHABService] - UUID = 890ac19c-1631-4e78-b462-aaf03cf97b6e, secret = PZ********************3W
2017-01-15 12:19:23.949 [DEBUG] [.myopenhab.internal.MyOpenHABService] - Using secret at '/var/lib/openhab2/myopenhab/secret' with content 'PZc**********************3W'
2017-01-15 12:19:24.102 [DEBUG] [org.openhab.io.myopenhab            ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.persistence.PersistenceService, org.eclipse.smarthome.core.events.EventSubscriber, org.eclipse.smarthome.model.script.engine.action.ActionService}={service.pid=org.openhab.myopenhab, service.config.category=io, service.config.label=my.openhab, component.name=org.openhab.myopenhab, component.id=192, service.config.description.uri=io:myopenhab, service.id=321, service.bundleid=208, service.scope=bundle} - org.openhab.io.myopenhab
2017-01-15 12:19:24.105 [DEBUG] [org.openhab.io.myopenhab            ] - BundleEvent STARTED - org.openhab.io.myopenhab
2017-01-15 12:19:24.155 [DEBUG] [org.openhab.core                    ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.model.sitemap.SitemapProvider}={component.name=org.openhab.defaultsitemapprovider, component.id=193, service.id=322, service.bundleid=166, service.scope=bundle} - org.openhab.core
2017-01-15 12:19:24.270 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Manager.EVENT_TRANSPORT
2017-01-15 12:19:24.349 [DEBUG] [org.openhab.core                    ] - ServiceEvent REGISTERED - {javax.servlet.ServletContext}={osgi.web.symbolicname=org.openhab.core, osgi.web.version=2.0.0.201701141030, osgi.web.contextpath=/, service.id=323, service.bundleid=166, service.scope=singleton} - org.openhab.core
2017-01-15 12:19:24.366 [DEBUG] [org.openhab.core                    ] - BundleEvent STARTING - org.openhab.core
2017-01-15 12:19:24.536 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Transport.EVENT_REQUEST_HEADERS
2017-01-15 12:19:25.648 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Manager.EVENT_TRANSPORT
2017-01-15 12:19:25.670 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Transport.EVENT_REQUEST_HEADERS
2017-01-15 12:19:25.965 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Transport.EVENT_REQUEST_HEADERS
2017-01-15 12:19:26.382 [DEBUG] [org.openhab.core                    ] - BundleEvent STARTED - org.openhab.core
2017-01-15 12:19:26.706 [ERROR] [o.myopenhab.internal.MyOpenHABClient] - Socket.IO error: not authorized
2017-01-15 12:19:26.710 [TRACE] [o.myopenhab.internal.MyOpenHABClient] - Transport.EVENT_REQUEST_HEADERS

I made one triple check and both secret and uuid are correct, and reinstalled the openhab 3 times. Something is missing but i cant figure out.

Regards,
Jaime

2

Wrong Java version?
You need Oracle Java with at least version 101 …

3

@sihui My version is earlier. take a look:

jmv@homeautomation:~$ java -version
java version "1.8.0_111"
Java(TM) SE Runtime Environment (build 1.8.0_111-b14)
Java HotSpot(TM) Server VM (build 25.111-b14, mixed mode)
4

Looks good.

The only thing I can think of then: did you verify (click on the provided link) the registration email from myopenhab.org?

5

Yes I clicked! :frowning:

6

It seems you did everything right, so I’m out of ideas.
Maybe read through the setup again and verify you did all the steps needed:

http://docs.openhab.org/addons/io/openhabcloud/readme.html

And make sure you have only the openHAB Cloud Connector installed, not the old my.openhab, because in your debug log this line looks a little strange to me:

cloud.JPG1220×160 12.9 KB

7

Do you use any non-standard things like a different port or a reverse proxy?

8

Today I will try to install all from scratch, including OS (Lubuntu), Java 8 and OpenHab2 snapshot and the cloud connector.

Yes it is strange, but I made the upgrade exactly because of the shutdown of myopenhab.

9

No, nothing strange. Fresh installed Lubuntu, with one Java fresh intallation, and the latest snapshot of openhab. My network topology is the common one of all private homes and the server has no other things installed.

10

Before you do that you should verify that no leftovers from the old my.openhab are present anymore:
check your /addons folder and PaperUI.
If both services are installed the same time the new cloud connector won’t work (according to another recent post)

11

I haven’t installed the my.openhab. As I said, I installed the OS lubuntu with full HDD format, so there are no leftovers.
It is possible that myopenhab is configured by default in the expert package?? If not, my answer is 100% no my.openhab is not installed!
I’m not at home, I cannot send you one printscreen. Thanks for your help sihui!

12

No:
http://docs.openhab.org/configuration/packages.html#expert-package-best-for-1x-users

Unfortunately with no success … good luck.

13

@sihui
Yesterday I had perform one clean installation and now everything works. It was very strange, because I don’t remember do anything different!
Regards

1 Like
14

Since a couple of days I have also socket io errors on the cloud connection and I equally have lost KNX/IP links, and ultimately it leading to an unstable, crashed system. Restarting nor unloading the openhab cloud service helps.
I reinstalled the latest openHAB distribution (2.1.0 snapshot in my case), reconfigured (bindings etc.), restored a few config files, update the openhab cloud uuid & secret on the account with the new values.
I am running java version 8 update 121 on Mac OSX and using mapdb as persistence store.
Strange but maybe worth mentioning, the only difference I can remember was the OSX update to 10.12.4.
But around 45 minutes after launching openhab the issue reoccurs.

Solved After 2 reboots and restarting my OS X Server application. It looks like the OS X update was not fully finalized and I had forgotten to restart properly my OS X server. After these steps the issue disappeared.

Log file extract:

23:12:14.160 [ERROR] [io.openhabcloud.internal.CloudClient] - Socket.IO error: io.socket.engineio.client.EngineIOException: websocket error
23:12:14.161 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = XXXXXX, base URL = http://localhost:8080)
23:12:15.426 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = XXXXXX, base URL = http://localhost:8080)
23:12:35.900 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: connection state response status: server could not find active data connection with specified ID
23:12:45.902 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: connection state response status: server could not find active data connection with specified ID
23:12:55.908 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: connection state response status: server could not find active data connection with specified ID
23:13:05.909 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: connection state response status: server could not find active data connection with specified ID
23:13:15.913 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: received disconnect response status 0x21 (no active data connection with that ID)
23:13:15.913 [WARN ] [tuwien.auto.calimero                ] - KNXnet/IP Tunneling 192.168.1.249:3671: close connection - no heartbeat response
23:13:15.914 [WARN ] [nx.internal.connection.KNXConnection] - KNX link has been lost (reason: no heartbeat response on object tunneling link link (closed) 192.168.1.249:3671 TP1 medium, device 0.0.0, hopcount 6)
23:13:15.915 [ERROR] [.binding.knx.internal.bus.KNXBinding] - Received detach Event.