Another my.openhab.org shows offline problem

Hi

I run openhab 1.8 on raspberry pi 3 on raspbian with following configurations:
java version "1.8.0_65"
Java™ SE Runtime Environment (build 1.8.0_65-b17)
Java HotSpot™ Client VM (build 25.65-b01, mixed mode)

security:option=EXTERNAL
security:netmask=192.168.1.0/24

I have created myopenhab.persist in /opt/openhab/configurations/persistence folder with following contents:
Strategies {
default = everyChange
}
Items {

  • : strategy = everyChange
    }

I checked my secret and UUID and they are properly setup in my.openhab account.

I even added security certificate to keystore, but still my.openhab.org shows offline.

here’s what I see in my log

2016-08-28 07:35:11.535 [INFO ] [.o.core.internal.CoreActivator] - openHAB runtime has been started (v1.8.3).
2016-08-28 07:35:16.162 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - mDNS service has been started
2016-08-28 07:35:16.367 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - Service Discovery initialization completed.
2016-08-28 07:35:24.716 [INFO ] [penhab.io.rest.RESTApplication] - Started REST API at /rest
2016-08-28 07:35:24.770 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'pore.sitemap'
2016-08-28 07:35:25.704 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'mysql.persist'
2016-08-28 07:35:25.809 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'logging.persist'
2016-08-28 07:35:25.840 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'exec.persist'
2016-08-28 07:35:25.861 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'db4o.persist'
2016-08-28 07:35:25.881 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'myopenhab.persist'
2016-08-28 07:35:25.905 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'rrd4j.persist'
2016-08-28 07:35:25.944 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'jdbc.persist'
2016-08-28 07:35:26.130 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'demo.script'
2016-08-28 07:35:26.619 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'demo.items'
2016-08-28 07:35:30.818 [INFO ] [.o.u.w.i.servlet.WebAppServlet] - Started Classic UI at /classicui/openhab.app
2016-08-28 07:35:35.807 [ERROR] [b.b.i.BTDeviceDiscoveryService] - Error while initializing local bluetooth device.
javax.bluetooth.BluetoothStateException: BlueCove com.intel.bluetooth.BluetoothStackBlueZ|com.intel.bluetooth.BluetoothStackBlueZDBus not available
        at com.intel.bluetooth.BlueCoveImpl.loadStackClass(BlueCoveImpl.java:363) ~[na:na]
        at com.intel.bluetooth.BlueCoveImpl.detectStack(BlueCoveImpl.java:454) ~[na:na]
        at com.intel.bluetooth.BlueCoveImpl.access$500(BlueCoveImpl.java:70) ~[na:na]
        at com.intel.bluetooth.BlueCoveImpl$1.run(BlueCoveImpl.java:1085) ~[na:na]
        at java.security.AccessController.doPrivileged(Native Method) ~[na:1.8.0_65]
        at com.intel.bluetooth.BlueCoveImpl.detectStackPrivileged(BlueCoveImpl.java:1083) ~[na:na]
        at com.intel.bluetooth.BlueCoveImpl.getBluetoothStack(BlueCoveImpl.java:1076) ~[na:na]
        at javax.bluetooth.LocalDevice.getLocalDeviceInstance(LocalDevice.java:75) ~[na:na]
        at javax.bluetooth.LocalDevice.getLocalDevice(LocalDevice.java:95) ~[na:na]
        at org.openhab.binding.bluetooth.internal.BTDeviceDiscoveryService.run(BTDeviceDiscoveryService.java:113) ~[na:na]
2016-08-28 07:35:38.098 [INFO ] [.o.io.habmin.HABminApplication] - Started HABmin REST API at /services/habmin
2016-08-28 07:35:43.507 [INFO ] [.service.AbstractActiveService] - Exec Refresh Service has been started
2016-08-28 07:35:43.607 [WARN ] [o.p.m.i.MqttPersistenceService] - mqtt-persistence:broker
2016-08-28 07:35:43.608 [WARN ] [o.p.m.i.MqttPersistenceService] - mqtt-persistence:topic
2016-08-28 07:35:43.609 [WARN ] [o.p.m.i.MqttPersistenceService] - mqtt-persistence:message
2016-08-28 07:35:43.666 [INFO ] [.service.AbstractActiveService] - NTP Refresh Service has been started
2016-08-28 07:35:44.101 [ERROR] [.o.b.gpio.internal.GPIOBinding] - Error occured while creating backend object for item Light_GF_Kitchen_Table, exception: Device or re$
2016-08-28 07:35:44.103 [ERROR] [.o.b.gpio.internal.GPIOBinding] - Error occured while creating backend object for item Light_GF_Living_Front, exception: Device or res$
2016-08-28 07:35:44.105 [ERROR] [.o.b.gpio.internal.GPIOBinding] - Error occured while creating backend object for item Light_GF_Living_Mid, exception: Device or resou$
2016-08-28 07:35:44.531 [INFO ] [.service.AbstractActiveService] - HTTP Refresh Service has been started
2016-08-28 07:35:44.722 [INFO ] [.p.rrd4j.internal.RRD4jService] - Removing invalid defintion component = null heartbeat = 0 min/max = 0.0/0.0 step = 0 0 archives(s) =$
2016-08-28 07:35:45.153 [WARN ] [p.j.internal.JdbcConfiguration] - JDBC::updateConfig: try to load JDBC-driverClass: 'com.mysql.jdbc.Driver'

Here’s how it looks like when I ran it in debug mode.

07:43:58.276 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.293 [DEBUG] [.i.LoggingPersistenceActivator:31   ] - Logging persistence bundle has been started.
07:43:58.314 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.340 [DEBUG] [.p.internal.PersistenceManager:146  ] - Initializing logging persistence service.
07:43:58.354 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.374 [DEBUG] [.b.http.internal.HttpActivator:34   ] - HTTP binding has been started.
07:43:58.398 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.449 [INFO ] [.service.AbstractActiveService:169  ] - HTTP Refresh Service has been started
07:43:58.455 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.474 [DEBUG] [.zwave.internal.ZWaveActivator:36   ] - Z-Wave binding has been started.
07:43:58.498 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.542 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.567 [DEBUG] [.b.exec.internal.ExecActivator:34   ] - Exec binding has been started.
07:43:58.648 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.750 [INFO ] [.service.AbstractActiveService:169  ] - Exec Refresh Service has been started
07:43:58.755 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.813 [DEBUG] [.rrd4j.internal.RRD4jActivator:31   ] - RRD4j persistence bundle has been started.
07:43:58.835 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:58.877 [DEBUG] [.p.rrd4j.internal.RRD4jService:395  ] - Unknown property name : org.openhab.persistence.rrd4j
07:43:58.878 [DEBUG] [.p.rrd4j.internal.RRD4jService:364  ] - config 'objectClass' should have the format 'name.configkey'
07:43:58.881 [INFO ] [.p.rrd4j.internal.RRD4jService:407  ] - Removing invalid defintion component = null heartbeat = 0 min/max = 0.0/0.0 step = 0 0 archives(s) = [] 0 items(s) = []
07:43:58.883 [DEBUG] [.p.rrd4j.internal.RRD4jService:405  ] - Created default_other = GAUGE heartbeat = 3600 min/max = NaN/NaN step = 1 6 archives(s) = [ MAX xff = 0.999 steps = 1 rows = 3600 MAX xff = 0.999 steps = 10 rows = 1440 MAX xff = 0.999 steps = 60 rows = 1440 MAX xff = 0.999 steps = 900 rows = 2880 MAX xff = 0.999 steps = 21600 rows = 1460 MAX xff = 0.999 steps = 86400 rows = 3650] 0 items(s) = []
07:43:58.886 [DEBUG] [.p.rrd4j.internal.RRD4jService:405  ] - Created default_numeric = GAUGE heartbeat = 60 min/max = NaN/NaN step = 60 6 archives(s) = [ AVERAGE xff = 0.5 steps = 1 rows = 480 AVERAGE xff = 0.5 steps = 4 rows = 360 AVERAGE xff = 0.5 steps = 14 rows = 644 AVERAGE xff = 0.5 steps = 60 rows = 720 AVERAGE xff = 0.5 steps = 720 rows = 730 AVERAGE xff = 0.5 steps = 10080 rows = 520] 0 items(s) = []
07:43:58.893 [DEBUG] [.p.internal.PersistenceManager:146  ] - Initializing rrd4j persistence service.
07:43:58.931 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'DemoSwitch' does not exist.
07:43:58.939 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'NoOfLights' does not exist.
07:43:58.946 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'Window_GF_Toilet' does not exist.
07:43:58.953 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Heating' does not exist.
07:43:58.959 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Temperature' does not exist.
07:43:58.964 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Weather_Chart' does not exist.
07:43:58.979 [DEBUG] [.p.internal.PersistenceManager:428  ] - Scheduled strategy rrd4j.everyMinute with cron expression 0 * * * * ?
07:43:58.982 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:59.018 [DEBUG] [p.r.i.charts.RRD4jChartServlet:118  ] - Starting up rrd chart servlet at /rrdchart.png
07:43:59.023 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:59.136 [ERROR] [.o.b.gpio.internal.GPIOBinding:363  ] - Error occured while creating backend object for item Light_GF_Kitchen_Table, exception: Device or resource busy
07:43:59.139 [ERROR] [.o.b.gpio.internal.GPIOBinding:363  ] - Error occured while creating backend object for item Light_GF_Living_Front, exception: Device or resource busy
07:43:59.141 [ERROR] [.o.b.gpio.internal.GPIOBinding:363  ] - Error occured while creating backend object for item Light_GF_Living_Mid, exception: Device or resource busy
07:43:59.151 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:59.178 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:59.198 [DEBUG] [.o.b.ntp.internal.NtpActivator:31   ] - NTP binding has been started.
07:43:59.221 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:43:59.258 [INFO ] [.service.AbstractActiveService:169  ] - NTP Refresh Service has been started
07:43:59.259 [DEBUG] [inding.ntp.internal.NtpBinding:78   ] - There is no existing NTP binding configuration => refresh cycle aborted!
07:43:59.262 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
07:44:00.070 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'DemoSwitch' does not exist.
07:44:00.073 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'NoOfLights' does not exist.
07:44:00.074 [DEBUG] [.p.internal.PersistenceManager:315  ] - Item 'Window_GF_Toilet' does not exist.
07:44:00.075 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Heating' does not exist.
07:44:00.077 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Temperature' does not exist.
07:44:00.078 [DEBUG] [.p.internal.PersistenceManager:328  ] - Item group 'Weather_Chart' does not exist.
07:44:01.031 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
07:44:01.034 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
07:44:06.538 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
07:44:06.541 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
07:44:12.069 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
07:44:12.072 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
07:44:17.566 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
07:44:17.569 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS

Any help to get this resolved is much appreciated.

Is this a “fresh” installation? Why didn’t you do an “apt-get” installation? Has my.openhab worked before or never yet?

Have you installed the demo sitemap? I see some demo files (demo.items), but also self-configured files (pore.sitemap). And I see some not so common bindings (mqtt and some other). Are they installed for a reason?

And I see Bluetooth errors. Are you using bluetooth devices for OH? Then you have to configure bluetooth on your RPi3 first.

And are you sure that the certificate is installed correctly? Why didn’t you do a update of JAVA?

I would suggest to delete the whole installation and start over from scratch using the apt-get method (tutorials are found all over the net and also in the OH wiki).

For some libraries, the apt-get method didnt find the installation, thats why I went with wget and manual setup. However, it never worked with my.openhab.

I have installed demo site map, and I copied it over to customize for my own. Some bindings such as mqtt are there from the demo setup.

I have noticed the bluetooth error, but never worried since I dont use it for anything yet.

Im not sure if certification works properly. How do I test that? If I can get that part tested, I would go for a fresh install.

Did a fresh install with apt-get method. Still no luck. Updated new secret and uuid, made changes to config and added required persistance libraries. This is my debug log.

13:52:12.893 [DEBUG] [.s.internal.SchedulerActivator:36   ] - Scheduler has been started.
13:52:13.106 [INFO ] [uartz.impl.StdSchedulerFactory:1175 ] - Using default implementation for ThreadExecutor
13:52:13.249 [INFO ] [rtz.core.SchedulerSignalerImpl:61   ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
13:52:13.251 [INFO ] [rg.quartz.core.QuartzScheduler:243  ] - Quartz Scheduler v.2.1.7 created.
13:52:13.260 [INFO ] [org.quartz.simpl.RAMJobStore  :154  ] - RAMJobStore initialized.
13:52:13.267 [INFO ] [rg.quartz.core.QuartzScheduler:268  ] - Scheduler meta-data: Quartz Scheduler (v2.1.7) 'openHAB-job-scheduler' with instanceId 'NON_CLUSTERED'
  Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
  NOT STARTED.
  Currently in standby mode.
  Number of jobs executed: 0
  Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 2 threads.
  Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.

13:52:13.270 [INFO ] [uartz.impl.StdSchedulerFactory:1324 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: '/etc/openhab/quartz.properties'
13:52:13.272 [INFO ] [uartz.impl.StdSchedulerFactory:1328 ] - Quartz scheduler version: 2.1.7
13:52:13.275 [INFO ] [rg.quartz.core.QuartzScheduler:534  ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
13:52:13.293 [DEBUG] [o.config.core.ConfigDispatcher:146  ] - Processing openHAB default configuration file '/usr/share/openhab/configurations/openhab_default.cfg'.
13:52:13.560 [DEBUG] [o.config.core.ConfigDispatcher:168  ] - Processing openHAB main configuration file '/etc/openhab/configurations/openhab.cfg'.
13:52:13.733 [DEBUG] [.o.core.internal.CoreActivator:93   ] - UUID file already exists at '/usr/share/openhab/webapps/static/uuid' with content '7a48cad1-bcf7-4e83-be59-8b3015f3b963'
13:52:13.745 [DEBUG] [.o.core.internal.CoreActivator:115  ] - Created file '/usr/share/openhab/webapps/static/version' with content '1.8.3'
13:52:13.749 [INFO ] [.o.core.internal.CoreActivator:61   ] - openHAB runtime has been started (v1.8.3).
13:52:13.856 [DEBUG] [a.internal.AutoUpdateActivator:31   ] - AutoUpdate binding has been started.
13:52:18.177 [DEBUG] [.p.i.PersistenceModelActivator:23   ] - Registered 'persistence' configuration parser
13:52:18.249 [DEBUG] [.c.t.i.TransformationActivator:38   ] - Transformation Service has been started.
13:52:18.399 [DEBUG] [m.internal.MultimediaActivator:34   ] - Multimedia I/O bundle has been started.
13:52:18.493 [DEBUG] [.s.i.DiscoveryServiceActivator:27   ] - Discovery service has been started.
13:52:18.562 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:93   ] - mDNS service has been started
13:52:18.615 [DEBUG] [.io.transport.mqtt.MqttService:123  ] - Starting MQTT Service...
13:52:18.805 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:53   ] - Service Discovery initialization completed.
13:52:19.125 [DEBUG] [.i.internal.ItemModelActivator:24   ] - Registered 'item' configuration parser
13:52:19.505 [DEBUG] [o.o.c.i.items.ItemRegistryImpl:137  ] - Item provider 'GenericItemProvider' has been added.
13:52:22.632 [DEBUG] [.o.m.s.i.SitemapModelActivator:23   ] - Registered 'sitemap' configuration parser
13:52:23.038 [DEBUG] [io.rest.internal.RESTActivator:33   ] - REST API has been started.
13:52:23.375 [INFO ] [org.atmosphere.util.IOUtils   :370  ] - META-INF/services/org.atmosphere.cpr.AtmosphereFramework not found in class loader
13:52:23.507 [INFO ] [sphere.cpr.AtmosphereFramework:2601 ] - Atmosphere is using org.atmosphere.cpr.DefaultAnnotationProcessor for processing annotation
13:52:23.513 [INFO ] [cpr.DefaultAnnotationProcessor:138  ] - AnnotationProcessor class org.atmosphere.cpr.DefaultAnnotationProcessor$BytecodeBasedAnnotationProcessor being used
13:52:23.600 [WARN ] [cpr.DefaultAnnotationProcessor:178  ] - Unable to detect annotations. Application may fail to deploy.
13:52:23.709 [INFO ] [sphere.cpr.AtmosphereFramework:1891 ] - Auto detecting atmosphere handlers /WEB-INF/classes/
13:52:23.795 [INFO ] [sphere.cpr.AtmosphereFramework:639  ] - Installed AtmosphereHandler org.atmosphere.handler.ReflectorServletProcessor mapped to context-path /* and Broadcaster Class org.atmosphere.jersey.JerseyBroadcaster
13:52:23.799 [INFO ] [sphere.cpr.AtmosphereFramework:1945 ] - Auto detecting WebSocketHandler in /WEB-INF/classes/
13:52:23.806 [INFO ] [sphere.cpr.AtmosphereFramework:1602 ] - Installed WebSocketProtocol org.atmosphere.websocket.protocol.SimpleHttpProtocol
13:52:24.009 [INFO ] [.a.h.ReflectorServletProcessor:103  ] - Installing Servlet com.sun.jersey.spi.container.servlet.ServletContainer
13:52:24.499 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:815  ] - Initiating Jersey application, version 'Jersey: 1.18.1 02/19/2014 03:28 AM'
13:52:24.510 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:826  ] - Adding the following classes declared in META-INF/services/jersey-server-components to the resource configuration:
  class org.atmosphere.jersey.AtmosphereResourceConfigurator
13:52:24.747 [INFO ] [j.s.i.a.DeferredResourceConfig:101  ] - Instantiated the Application class org.openhab.io.rest.RESTApplication
13:52:27.208 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'pore.sitemap'
13:52:27.945 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'mysql.persist'
13:52:28.061 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'logging.persist'
13:52:28.095 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'myopenhab.persist'
13:52:28.121 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'rrd4j.persist'
13:52:28.139 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'jdbc.persist'
13:52:28.294 [INFO ] [c.internal.ModelRepositoryImpl:80   ] - Loading model 'pore.items'
13:52:28.417 [DEBUG] [i.internal.GenericItemProvider:154  ] - Processing binding configs for items from model 'pore.items'
13:52:28.441 [DEBUG] [i.internal.GenericItemProvider:133  ] - Read items from model 'pore.items'
13:52:28.568 [INFO ] [sphere.cpr.AtmosphereFramework:2435 ] - AtmosphereInterceptor CORS Interceptor Support will always be executed first
13:52:28.571 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor CORS Interceptor Support with priority FIRST_BEFORE_DEFAULT
13:52:28.574 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Default Response's Headers Interceptor with priority AFTER_DEFAULT
13:52:28.583 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Android Interceptor Support with priority AFTER_DEFAULT
13:52:28.588 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor SSE Interceptor Support with priority AFTER_DEFAULT
13:52:28.592 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor JSONP Interceptor Support with priority AFTER_DEFAULT
13:52:28.599 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Atmosphere JavaScript Protocol with priority AFTER_DEFAULT
13:52:28.602 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Browser disconnection detection with priority AFTER_DEFAULT
13:52:28.618 [INFO ] [sphere.cpr.AtmosphereFramework:935  ] - Using EndpointMapper class org.atmosphere.util.DefaultEndpointMapper
13:52:28.624 [WARN ] [sphere.cpr.AtmosphereFramework:941  ] - No BroadcasterCache configured. Broadcasted message between client reconnection will be LOST. It is recommended to configure the org.atmosphere.cache.UUIDBroadcasterCache
13:52:28.626 [INFO ] [sphere.cpr.AtmosphereFramework:949  ] - Default Broadcaster Class: org.atmosphere.jersey.JerseyBroadcaster
13:52:28.628 [INFO ] [sphere.cpr.AtmosphereFramework:950  ] - Broadcaster Polling Wait Time 100
13:52:28.630 [INFO ] [sphere.cpr.AtmosphereFramework:951  ] - Shared ExecutorService supported: true
13:52:28.632 [INFO ] [sphere.cpr.AtmosphereFramework:958  ] - Messaging Thread Pool Size: 10
13:52:28.635 [INFO ] [sphere.cpr.AtmosphereFramework:968  ] - Async I/O Thread Pool Size: 10
13:52:28.637 [INFO ] [sphere.cpr.AtmosphereFramework:979  ] - Using BroadcasterFactory: org.atmosphere.cpr.DefaultBroadcasterFactory
13:52:28.639 [INFO ] [sphere.cpr.AtmosphereFramework:980  ] - Using WebSocketProcessor: org.atmosphere.websocket.DefaultWebSocketProcessor
13:52:28.641 [INFO ] [sphere.cpr.AtmosphereFramework:990  ] - Invoke AtmosphereInterceptor on WebSocket message true
13:52:28.643 [INFO ] [sphere.cpr.AtmosphereFramework:991  ] - HttpSession supported: false
13:52:28.645 [INFO ] [sphere.cpr.AtmosphereFramework:993  ] - Atmosphere is using DefaultAtmosphereObjectFactory for dependency injection and object creation
13:52:28.648 [INFO ] [sphere.cpr.AtmosphereFramework:994  ] - Atmosphere is using async support: org.atmosphere.container.JettyAsyncSupportWithWebSocket running under container: jetty/8.1.3.v20120522 with WebSocket enabled.
13:52:28.654 [INFO ] [sphere.cpr.AtmosphereFramework:996  ] - Atmosphere Framework 2.2.5 started.
13:52:28.656 [INFO ] [sphere.cpr.AtmosphereFramework:998  ] -

        For Atmosphere Framework Commercial Support, visit
        http://www.async-io.org/ or send an email to support@async-io.org

13:52:28.661 [INFO ] [penhab.io.rest.RESTApplication:144  ] - Started REST API at /rest
13:52:28.667 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66   ] - Registering new service _openhab-server._tcp.local. at port 8080
13:52:31.253 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66   ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443
13:52:34.053 [INFO ] [.o.u.w.i.servlet.WebAppServlet:80   ] - Started Classic UI at /classicui/openhab.app
13:52:35.145 [DEBUG] [.r.internal.RuleModelActivator:42   ] - Registered 'rules' configuration parser
13:52:35.189 [DEBUG] [m.r.internal.engine.RuleEngine:77   ] - Started rule engine
13:52:39.550 [DEBUG] [.m.i.MyOpenHABServiceActivator:27   ] - MyOpenHAB service has been started.
13:52:39.560 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:299  ] - setEventPublisher
13:52:39.561 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:134  ] - my.openHAB service activated
13:52:39.575 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:117  ] - config is null
13:52:39.580 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:175  ] - UUID file found at '/usr/share/openhab/webapps/static/uuid' with content '7a48cad1-bcf7-4e83-be59-8b3015f3b963'
13:52:39.582 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:227  ] - Secret file already exists at '/usr/share/openhab/webapps/static/secret' with content 'PBaipR0UkhLFZtVilJOJ'
13:52:39.584 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:119  ] - UUID = 7a48cad1-bcf7-4e83-be59-8b3015f3b963, secret = PBaipR0UkhLFZtVilJOJ
13:52:39.592 [DEBUG] [.p.internal.PersistenceManager:146  ] - Initializing myopenhab persistence service.
13:52:39.619 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:175  ] - UUID file found at '/usr/share/openhab/webapps/static/uuid' with content '7a48cad1-bcf7-4e83-be59-8b3015f3b963'
13:52:39.622 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:227  ] - Secret file already exists at '/usr/share/openhab/webapps/static/secret' with content 'PBaipR0UkhLFZtVilJOJ'
13:52:39.625 [DEBUG] [o.o.i.m.i.MyOpenHABServiceImpl:161  ] - Version file found at '/usr/share/openhab/webapps/static/version' with content '1.8.3'
13:52:39.755 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:52:39.843 [DEBUG] [nhab.io.habmin.HABminActivator:33   ] - HABmin Interface has been started.
13:52:39.907 [INFO ] [org.atmosphere.util.IOUtils   :370  ] - META-INF/services/org.atmosphere.cpr.AtmosphereFramework not found in class loader
13:52:39.946 [INFO ] [sphere.cpr.AtmosphereFramework:2601 ] - Atmosphere is using org.atmosphere.cpr.DefaultAnnotationProcessor for processing annotation
13:52:39.948 [INFO ] [cpr.DefaultAnnotationProcessor:138  ] - AnnotationProcessor class org.atmosphere.cpr.DefaultAnnotationProcessor$BytecodeBasedAnnotationProcessor being used
13:52:39.992 [WARN ] [cpr.DefaultAnnotationProcessor:178  ] - Unable to detect annotations. Application may fail to deploy.
13:52:40.147 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:52:40.186 [INFO ] [sphere.cpr.AtmosphereFramework:1891 ] - Auto detecting atmosphere handlers /WEB-INF/classes/
13:52:40.225 [INFO ] [sphere.cpr.AtmosphereFramework:639  ] - Installed AtmosphereHandler org.atmosphere.handler.ReflectorServletProcessor mapped to context-path /* and Broadcaster Class org.atmosphere.jersey.JerseyBroadcaster
13:52:40.227 [INFO ] [sphere.cpr.AtmosphereFramework:1945 ] - Auto detecting WebSocketHandler in /WEB-INF/classes/
13:52:40.242 [INFO ] [sphere.cpr.AtmosphereFramework:1602 ] - Installed WebSocketProtocol org.atmosphere.websocket.protocol.SimpleHttpProtocol
13:52:40.270 [INFO ] [.a.h.ReflectorServletProcessor:103  ] - Installing Servlet com.sun.jersey.spi.container.servlet.ServletContainer
13:52:40.293 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:815  ] - Initiating Jersey application, version 'Jersey: 1.18.1 02/19/2014 03:28 AM'
13:52:40.298 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:826  ] - Adding the following classes declared in META-INF/services/jersey-server-components to the resource configuration:
  class org.atmosphere.jersey.AtmosphereResourceConfigurator
13:52:40.419 [INFO ] [j.s.i.a.DeferredResourceConfig:101  ] - Instantiated the Application class org.openhab.io.habmin.HABminApplication
13:52:43.236 [WARN ] [sphere.cpr.AtmosphereFramework:1097 ] -
java.lang.ClassNotFoundException: org.atmosphere.interceptor.DefaultHeadersInterceptor
        at org.eclipse.osgi.internal.loader.BundleLoader.findClassInternal(BundleLoader.java:501) ~[org.eclipse.osgi_3.8.2.v20130124-134944.jar:na]
        at org.eclipse.osgi.internal.loader.BundleLoader.findClass(BundleLoader.java:421) ~[org.eclipse.osgi_3.8.2.v20130124-134944.jar:na]
        at org.eclipse.osgi.internal.loader.BundleLoader.findClass(BundleLoader.java:412) ~[org.eclipse.osgi_3.8.2.v20130124-134944.jar:na]
        at org.eclipse.osgi.internal.baseadaptor.DefaultClassLoader.loadClass(DefaultClassLoader.java:107) ~[org.eclipse.osgi_3.8.2.v20130124-134944.jar:na]
        at java.lang.ClassLoader.loadClass(ClassLoader.java:357) ~[na:1.8.0_65]
        at org.atmosphere.util.IOUtils.loadClass(IOUtils.java:309) ~[atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.atmosphere.cpr.AtmosphereFramework.configureAtmosphereInterceptor(AtmosphereFramework.java:1094) [atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:892) [atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:780) [atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.atmosphere.cpr.AtmosphereServlet.configureFramework(AtmosphereServlet.java:101) [atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.atmosphere.cpr.AtmosphereServlet.init(AtmosphereServlet.java:80) [atmosphere-runtime-2.2.5.jar:2.2.5]
        at org.eclipse.equinox.http.servlet.internal.ServletRegistration.init(ServletRegistration.java:49) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na]
        at org.eclipse.equinox.http.servlet.internal.ProxyServlet.registerServlet(ProxyServlet.java:179) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na]
        at org.eclipse.equinox.http.servlet.internal.HttpServiceImpl.registerServlet(HttpServiceImpl.java:66) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na]
        at org.openhab.io.habmin.HABminApplication.activate(HABminApplication.java:178) [bundlefile:na]
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_65]
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_65]
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_65]
        at java.lang.reflect.Method.invoke(Method.java:497) ~[na:1.8.0_65]
        at org.eclipse.equinox.internal.ds.model.ServiceComponent.activate(ServiceComponent.java:235) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.model.ServiceComponentProp.activate(ServiceComponentProp.java:146) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.model.ServiceComponentProp.build(ServiceComponentProp.java:345) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.InstanceProcess.buildComponent(InstanceProcess.java:620) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.InstanceProcess.buildComponents(InstanceProcess.java:197) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.Resolver.buildNewlySatisfied(Resolver.java:473) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.Resolver.enableComponents(Resolver.java:217) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.SCRManager.performWork(SCRManager.java:816) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.SCRManager$QueuedJob.dispatch(SCRManager.java:783) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.ds.WorkThread.run(WorkThread.java:89) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na]
        at org.eclipse.equinox.internal.util.impl.tpt.threadpool.Executor.run(Executor.java:70) [org.eclipse.equinox.util_1.0.400.v20120917-192807.jar:na]
13:52:43.241 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Android Interceptor Support with priority AFTER_DEFAULT
13:52:43.243 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor SSE Interceptor Support with priority AFTER_DEFAULT
13:52:43.245 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor JSONP Interceptor Support with priority AFTER_DEFAULT
13:52:43.247 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Atmosphere JavaScript Protocol with priority AFTER_DEFAULT
13:52:43.249 [INFO ] [sphere.cpr.AtmosphereFramework:2404 ] - Installed AtmosphereInterceptor Browser disconnection detection with priority AFTER_DEFAULT
13:52:43.251 [INFO ] [sphere.cpr.AtmosphereFramework:935  ] - Using EndpointMapper class org.atmosphere.util.DefaultEndpointMapper
13:52:43.253 [WARN ] [sphere.cpr.AtmosphereFramework:941  ] - No BroadcasterCache configured. Broadcasted message between client reconnection will be LOST. It is recommended to configure the org.atmosphere.cache.UUIDBroadcasterCache
13:52:43.254 [INFO ] [sphere.cpr.AtmosphereFramework:949  ] - Default Broadcaster Class: org.atmosphere.jersey.JerseyBroadcaster
13:52:43.256 [INFO ] [sphere.cpr.AtmosphereFramework:950  ] - Broadcaster Polling Wait Time 100
13:52:43.257 [INFO ] [sphere.cpr.AtmosphereFramework:951  ] - Shared ExecutorService supported: true
13:52:43.259 [INFO ] [sphere.cpr.AtmosphereFramework:958  ] - Messaging Thread Pool Size: Unlimited
13:52:43.260 [INFO ] [sphere.cpr.AtmosphereFramework:968  ] - Async I/O Thread Pool Size: 200
13:52:43.262 [INFO ] [sphere.cpr.AtmosphereFramework:979  ] - Using BroadcasterFactory: org.atmosphere.cpr.DefaultBroadcasterFactory
13:52:43.264 [INFO ] [sphere.cpr.AtmosphereFramework:980  ] - Using WebSocketProcessor: org.atmosphere.websocket.DefaultWebSocketProcessor
13:52:43.265 [INFO ] [sphere.cpr.AtmosphereFramework:990  ] - Invoke AtmosphereInterceptor on WebSocket message true
13:52:43.267 [INFO ] [sphere.cpr.AtmosphereFramework:991  ] - HttpSession supported: false
13:52:43.268 [INFO ] [sphere.cpr.AtmosphereFramework:993  ] - Atmosphere is using DefaultAtmosphereObjectFactory for dependency injection and object creation
13:52:43.270 [INFO ] [sphere.cpr.AtmosphereFramework:994  ] - Atmosphere is using async support: org.atmosphere.container.JettyAsyncSupportWithWebSocket running under container: jetty/8.1.3.v20120522 with WebSocket enabled.
13:52:43.272 [INFO ] [sphere.cpr.AtmosphereFramework:996  ] - Atmosphere Framework 2.2.5 started.
13:52:43.273 [INFO ] [sphere.cpr.AtmosphereFramework:998  ] -

        For Atmosphere Framework Commercial Support, visit
        http://www.async-io.org/ or send an email to support@async-io.org

13:52:43.284 [INFO ] [.o.io.habmin.HABminApplication:181  ] - Started HABmin REST API at /services/habmin
13:52:43.287 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66   ] - Registering new service _openhab-server._tcp.local. at port 8080
13:52:45.903 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66   ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443
13:52:46.620 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:52:46.624 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:52:48.609 [DEBUG] [sqlPersistenceServiceActivator:32   ] - mySQL persistence bundle has been started.
13:52:48.656 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:48.901 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:48.922 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:48.939 [DEBUG] [o.o.b.g.i.GPIOBindingActivator:30   ] - GPIO binding has been started.
13:52:48.964 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:48.990 [DEBUG] [i.internal.GenericItemProvider:341  ] - Start processing binding configuration of Item 'GF_LIVING_FR (Type=SwitchItem, State=Uninitialized)' with 'GPIOGenericBindingProvider' reader.
13:52:48.995 [DEBUG] [i.internal.GenericItemProvider:341  ] - Start processing binding configuration of Item 'GF_LIVING_MD (Type=DimmerItem, State=Uninitialized)' with 'GPIOGenericBindingProvider' reader.
13:52:49.028 [ERROR] [.o.b.gpio.internal.GPIOBinding:363  ] - Error occured while creating backend object for item GF_LIVING_MD, exception: /sys/class/gpio/export
13:52:49.031 [ERROR] [.o.b.gpio.internal.GPIOBinding:363  ] - Error occured while creating backend object for item GF_LIVING_FR, exception: /sys/class/gpio/export
13:52:49.039 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:49.070 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:49.202 [DEBUG] [o.p.j.i.JdbcPersistenceService:89   ] - JDBC::setItemRegistry
13:52:49.204 [DEBUG] [o.p.j.i.JdbcPersistenceService:59   ] - JDBC::activate: persistence service activated
13:52:49.206 [DEBUG] [o.p.j.i.JdbcPersistenceService:215  ] - JDBC::updateConfig
13:52:49.218 [DEBUG] [p.j.internal.JdbcConfiguration:64   ] - JDBC::JdbcConfiguration
13:52:49.220 [DEBUG] [p.j.internal.JdbcConfiguration:72   ] - JDBC::updateConfig: configuration.size = 10
13:52:49.228 [DEBUG] [p.j.internal.JdbcConfiguration:77   ] - JDBC::updateConfig: url=jdbc:mysql://localhost:3306/openhab
13:52:49.230 [DEBUG] [p.j.internal.JdbcConfiguration:87   ] - JDBC::updateConfig: found serviceName = 'mysql'
13:52:49.232 [DEBUG] [p.j.internal.JdbcConfiguration:98   ] - JDBC::updateConfig: Init Data Access Object Class: 'org.openhab.persistence.jdbc.db.JdbcMysqlDAO'
13:52:49.290 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:109  ] - JDBC::initSqlTypes: Initialize the type array
13:52:49.292 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:82   ] - JDBC::initSqlQueries: 'JdbcMysqlDAO'
13:52:49.294 [DEBUG] [rsistence.jdbc.db.JdbcMysqlDAO:45   ] - JDBC::initSqlTypes: Initialize the type array
13:52:49.296 [DEBUG] [rsistence.jdbc.db.JdbcMysqlDAO:38   ] - JDBC::initSqlQueries: 'JdbcMysqlDAO'
13:52:49.298 [DEBUG] [p.j.internal.JdbcConfiguration:105  ] - JDBC::updateConfig: dBDAO ClassName=org.openhab.persistence.jdbc.db.JdbcMysqlDAO
13:52:49.303 [DEBUG] [p.j.internal.JdbcConfiguration:144  ] - JDBC::updateConfig:  user=openhabuser
13:52:49.305 [DEBUG] [p.j.internal.JdbcConfiguration:157  ] - JDBC::updateConfig:  password=<masked> password.length=8
13:52:49.306 [DEBUG] [p.j.internal.JdbcConfiguration:170  ] - JDBC::updateConfig: tableNamePrefix=Item
13:52:49.308 [DEBUG] [p.j.internal.JdbcConfiguration:182  ] - JDBC::updateConfig: tableUseRealItemNames=false
13:52:49.310 [DEBUG] [p.j.internal.JdbcConfiguration:188  ] - JDBC::updateConfig: tableIdDigitCount=0
13:52:49.312 [DEBUG] [p.j.internal.JdbcConfiguration:216  ] - JDBC::updateConfig: enableLogTime false
13:52:49.313 [WARN ] [p.j.internal.JdbcConfiguration:237  ] - JDBC::updateConfig: try to load JDBC-driverClass: 'com.mysql.jdbc.Driver'
13:52:49.333 [DEBUG] [p.j.internal.JdbcConfiguration:240  ] - JDBC::updateConfig: load JDBC-driverClass was successful: 'com.mysql.jdbc.Driver'
13:52:49.335 [DEBUG] [p.j.internal.JdbcConfiguration:266  ] - JDBC::updateConfig: configuration complete. service=jdbc
13:52:49.337 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:41   ] - JDBC::pingDB
13:52:49.339 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:161  ] - JDBC::openConnection isDriverAvailable: true
13:52:49.340 [WARN ] [o.o.p.jdbc.internal.JdbcMapper:163  ] - JDBC::openConnection: setupDataSource.
13:52:49.397 [INFO ] [zaxxer.hikari.HikariDataSource:70   ] - HikariPool-0 - is starting.
13:52:49.726 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:52:49.729 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:52:50.894 [INFO ] [org.knowm.yank.YankPoolManager:83   ] - Initialized pool 'HikariPool-0'
13:52:50.906 [DEBUG] [p.j.internal.JdbcConfiguration:323  ] - JDBC::setDbConnected true
13:52:51.074 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:75   ] - JDBC::createItemsTableIfNot
13:52:51.077 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:230  ] - JDBC::doCreateItemsTableIfNot sql=CREATE TABLE IF NOT EXISTS items (ItemId INT NOT NULL AUTO_INCREMENT,itemname VARCHAR(500) NOT NULL,PRIMARY KEY (ItemId))
13:52:51.082 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:91   ] - JDBC::getItemIDTableNames
13:52:51.084 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:245  ] - JDBC::doGetItemIDTableNames sql=SELECT itemid, itemname FROM items
13:52:51.119 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.122 [DEBUG] [o.p.j.i.JdbcPersistenceService:226  ] - JDBC::updateConfig: configuration complete for service=jdbc.
13:52:51.129 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.132 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.134 [DEBUG] [.p.internal.PersistenceManager:146  ] - Initializing jdbc persistence service.
13:52:51.137 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.139 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.141 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.162 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.166 [DEBUG] [o.p.j.i.JdbcPersistenceService:104  ] - JDBC::getName: returning name 'jdbc' for queryable persistence service.
13:52:51.169 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:51.187 [DEBUG] [.zwave.internal.ZWaveActivator:36   ] - Z-Wave binding has been started.
13:52:51.211 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:51.261 [DEBUG] [.p.m.i.MysqlPersistenceService:475  ] - mySQL: Attempting to connect to database jdbc:mysql://localhost:3306/openhab
13:52:55.297 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:52:55.310 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:53:00.836 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:53:00.852 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:53:06.388 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:53:06.391 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS
13:53:12.043 [DEBUG] [.myopenhab.internal.MyOHClient:137  ] - Manager.EVENT_TRANSPORT
13:53:12.047 [DEBUG] [.myopenhab.internal.MyOHClient:142  ] - Transport.EVENT_REQUEST_HEADERS

The java version is your problem, you need a version 101 or newer:

1 Like

**

You are a genius!!!

**

Thank you so much! It is working ok now!

Not at all, just reading a lot of posts here :grinning:

For the record and future readers, you can run the apt-get install AND manually install those addons that are not part of apt-get by simply placing the jar files into your /usr/share/openhab/addons folder.