Closed gerhut2000 closed 9 years ago
Hi @gerhut2000, no not afaik!
@belovictor @gerrieg any idea what could cause this issue? What exactly happens to the second service? Could you please start in Debug mode and see if there is anything helpful in the openhab.log?
Best, Thomas E.-E.
Hi Thomas
I attached the logging file. The second service (mostly the weather) simply does not start/no temperatur is seen.
What information of the openhab.cfg are interesting for you?
Thanks so far.
2015-05-16 21:18 GMT+02:00 Thomas Eichstädt-Engelen < notifications@github.com>:
Hi @gerhut2000 https://github.com/gerhut2000, no not afaik!
@belovictor https://github.com/belovictor @gerrieg https://github.com/gerrieg any idea what could cause this issue? What exactly happens to the second service? Could you please start in Debug mode and see if there is anything helpful in the openhab.log?
Best, Thomas E.-E.
— Reply to this email directly or view it on GitHub https://github.com/openhab/openhab/issues/2530#issuecomment-102667512.
11:16:13.818 [DEBUG] [.s.internal.SchedulerActivator:36 ] - Scheduler has been started. 11:16:14.587 [INFO ] [uartz.impl.StdSchedulerFactory:1175 ] - Using default implementation for ThreadExecutor 11:16:14.932 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 11:16:14.939 [INFO ] [rg.quartz.core.QuartzScheduler:243 ] - Quartz Scheduler v.2.1.7 created. 11:16:14.970 [INFO ] [org.quartz.simpl.RAMJobStore :154 ] - RAMJobStore initialized. 11:16:15.002 [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.
11:16:15.012 [INFO ] [uartz.impl.StdSchedulerFactory:1324 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: './etc/quartz.properties' 11:16:15.018 [INFO ] [uartz.impl.StdSchedulerFactory:1328 ] - Quartz scheduler version: 2.1.7 11:16:15.040 [INFO ] [rg.quartz.core.QuartzScheduler:534 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started. 11:16:15.127 [DEBUG] [o.config.core.ConfigDispatcher:146 ] - Processing openHAB default configuration file '/opt/openhab/configurations/openhab_default.cfg'. 11:16:16.247 [DEBUG] [o.config.core.ConfigDispatcher:168 ] - Processing openHAB main configuration file '/opt/openhab/configurations/openhab.cfg'. 11:16:17.684 [DEBUG] [.o.core.internal.CoreActivator:93 ] - UUID file already exists at '/opt/openhab/webapps/static/uuid' with content 'bdb1dcd7-155f-4392-b557-951091982389' 11:16:17.694 [DEBUG] [.o.core.internal.CoreActivator:115 ] - Created file '/opt/openhab/webapps/static/version' with content '1.6.2' 11:16:17.699 [INFO ] [.o.core.internal.CoreActivator:61 ] - openHAB runtime has been started (v1.6.2). 11:16:18.476 [DEBUG] [a.internal.AutoUpdateActivator:31 ] - AutoUpdate binding has been started. 11:16:39.022 [DEBUG] [.p.i.PersistenceModelActivator:23 ] - Registered 'persistence' configuration parser 11:16:39.425 [DEBUG] [.c.t.i.TransformationActivator:38 ] - Transformation Service has been started. 11:16:40.184 [DEBUG] [m.internal.MultimediaActivator:34 ] - Multimedia I/O bundle has been started. 11:16:40.981 [DEBUG] [.s.i.DiscoveryServiceActivator:27 ] - Discovery service has been started. 11:16:41.116 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:93 ] - mDNS service has been started 11:16:41.795 [DEBUG] [.io.transport.mqtt.MqttService:123 ] - Starting MQTT Service... 11:16:42.972 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl:53 ] - Service Discovery initialization completed. 11:16:43.163 [INFO ] [.io.transport.mqtt.MqttService:108 ] - MQTT Service initialization completed. 11:16:43.181 [INFO ] [o.i.t.m.i.MqttBrokerConnection:114 ] - Starting MQTT broker connection 'localbroker' 11:16:43.892 [DEBUG] [o.i.t.m.i.MqttBrokerConnection:294 ] - Creating new client for 'tcp://localhost:1883' using id 'root.1431854203731' and file store '/tmp/localbroker' 11:16:45.876 [ERROR] [.io.transport.mqtt.MqttService:114 ] - Error starting broker connection org.eclipse.paho.client.mqttv3.MqttException: Verbindung zu Server kann nicht hergestellt werden at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:75) ~[na:na] at org.eclipse.paho.client.mqttv3.internal.ClientComms$ConnectBG.run(ClientComms.java:538) ~[na:na] at java.lang.Thread.run(Thread.java:744) ~[na:1.8.0] Caused by: java.net.ConnectException: Verbindungsaufbau abgelehnt at java.net.PlainSocketImpl.socketConnect(Native Method) ~[na:1.8.0] at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345) ~[na:1.8.0] at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[na:1.8.0] at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[na:1.8.0] at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[na:1.8.0] at java.net.Socket.connect(Socket.java:589) ~[na:1.8.0] at org.eclipse.paho.client.mqttv3.internal.TCPNetworkModule.start(TCPNetworkModule.java:66) ~[na:na] ... 2 common frames omitted 11:16:47.662 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'rrd4j.persist' 11:16:50.358 [DEBUG] [.i.internal.ItemModelActivator:24 ] - Registered 'item' configuration parser 11:16:51.468 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'logging.persist' 11:16:51.787 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'exec.persist' 11:16:52.398 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'mysql.persist' 11:16:53.363 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'test.items' 11:16:55.120 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'test.items' 11:16:55.178 [DEBUG] [o.o.c.i.items.ItemRegistryImpl:137 ] - Item provider 'GenericItemProvider' has been added. 11:16:55.191 [DEBUG] [i.internal.GenericItemProvider:133 ] - Read items from model 'test.items' 11:17:08.418 [DEBUG] [.o.m.s.i.SitemapModelActivator:23 ] - Registered 'sitemap' configuration parser 11:17:09.723 [DEBUG] [io.rest.internal.RESTActivator:33 ] - REST API has been started. 11:17:11.091 [INFO ] [sphere.cpr.AtmosphereFramework:2175 ] - Atmosphere is using org.atmosphere.cpr.DefaultAnnotationProcessor for processing annotation 11:17:11.104 [INFO ] [cpr.DefaultAnnotationProcessor:131 ] - AnnotationProcessor class org.atmosphere.cpr.DefaultAnnotationProcessor$BytecodeBasedAnnotationProcessor being used 11:17:11.926 [ERROR] [sphere.cpr.AtmosphereFramework:2215 ] - java.lang.ClassCastException: org.eclipse.osgi.framework.internal.core.BundleURLConnection cannot be cast to java.net.JarURLConnection at org.atmosphere.util.annotation.AnnotationDetector.detect(AnnotationDetector.java:325) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.DefaultAnnotationProcessor.scanForAnnotation(DefaultAnnotationProcessor.java:148) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.DefaultAnnotationProcessor.configure(DefaultAnnotationProcessor.java:134) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.autoConfigureService(AtmosphereFramework.java:2177) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:655) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:568) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereServlet.configureFramework(AtmosphereServlet.java:91) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereServlet.init(AtmosphereServlet.java:80) [atmosphere-runtime-2.0.9.jar:2.0.9] 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.rest.RESTApplication.activate(RESTApplication.java:140) [org.openhab.io.rest_1.6.2.jar:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0] at java.lang.reflect.Method.invoke(Method.java:483) ~[na:1.8.0] 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.getEligible(Resolver.java:343) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na] at org.eclipse.equinox.internal.ds.SCRManager.serviceChanged(SCRManager.java:222) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na] at org.eclipse.osgi.internal.serviceregistry.FilteredServiceListener.serviceChanged(FilteredServiceListener.java:107) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.framework.internal.core.BundleContextImpl.dispatchEvent(BundleContextImpl.java:861) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEventPrivileged(ServiceRegistry.java:819) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.publishServiceEvent(ServiceRegistry.java:771) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.internal.serviceregistry.ServiceRegistrationImpl.register(ServiceRegistrationImpl.java:130) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.internal.serviceregistry.ServiceRegistry.registerService(ServiceRegistry.java:214) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.framework.internal.core.BundleContextImpl.registerService(BundleContextImpl.java:433) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.equinox.internal.ds.InstanceProcess.registerService(InstanceProcess.java:536) [org.eclipse.equinox.ds_1.4.1.v20120926-201320.jar:na] at org.eclipse.equinox.internal.ds.InstanceProcess.buildComponents(InstanceProcess.java:260) [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] 11:17:12.044 [INFO ] [sphere.cpr.AtmosphereFramework:1506 ] - Auto detecting atmosphere handlers /WEB-INF/classes/ 11:17:12.180 [WARN ] [sphere.cpr.AtmosphereFramework:1154 ] - Missing META-INF/atmosphere.xml but found the Jersey runtime. Starting Jersey 11:17:13.318 [INFO ] [sphere.cpr.AtmosphereFramework:434 ] - Installed AtmosphereHandler org.atmosphere.handler.ReflectorServletProcessor mapped to context-path: /* 11:17:13.326 [INFO ] [sphere.cpr.AtmosphereFramework:1561 ] - Auto detecting WebSocketHandler in /WEB-INF/classes/ 11:17:13.351 [INFO ] [sphere.cpr.AtmosphereFramework:1259 ] - Installed WebSocketProtocol org.atmosphere.websocket.protocol.SimpleHttpProtocol 11:17:14.125 [INFO ] [.a.h.ReflectorServletProcessor:140 ] - Installing Servlet com.sun.jersey.spi.container.servlet.ServletContainer 11:17:17.912 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'test.sitemap' 11:17:18.503 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:790 ] - Initiating Jersey application, version 'Jersey: 1.17.1 02/28/2013 12:47 PM' 11:17:18.690 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:801 ] - Adding the following classes declared in META-INF/services/jersey-server-components to the resource configuration: class org.atmosphere.jersey.AtmosphereResourceConfigurator 11:17:21.674 [INFO ] [j.s.i.a.DeferredResourceConfig:101 ] - Instantiated the Application class org.openhab.io.rest.RESTApplication 11:17:24.691 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'demo.script' 11:17:40.677 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Default Response's Headers Interceptor with priority AFTER_DEFAULT 11:17:40.727 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Android Interceptor Support with priority AFTER_DEFAULT 11:17:40.771 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor SSE Interceptor Support with priority AFTER_DEFAULT 11:17:40.788 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor JSONP Interceptor Support with priority AFTER_DEFAULT 11:17:40.827 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Atmosphere JavaScript Protocol with priority AFTER_DEFAULT 11:17:40.845 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Browser disconnection detection with priority AFTER_DEFAULT 11:17:40.852 [INFO ] [sphere.cpr.AtmosphereFramework:826 ] - Installing Default AtmosphereInterceptor 11:17:40.937 [WARN ] [sphere.cpr.AtmosphereFramework:703 ] - No BroadcasterCache configured. Broadcasted message between client reconnection will be LOST. It is recommended to configure the org.atmosphere.cache.UUIDBroadcasterCache 11:17:40.966 [INFO ] [sphere.cpr.AtmosphereFramework:711 ] - Broadcaster Polling Wait Time 100 11:17:40.991 [INFO ] [sphere.cpr.AtmosphereFramework:712 ] - Shared ExecutorService supported: true 11:17:41.019 [INFO ] [sphere.cpr.AtmosphereFramework:713 ] - HttpSession supported: false 11:17:41.050 [INFO ] [sphere.cpr.AtmosphereFramework:714 ] - Using BroadcasterFactory: org.atmosphere.cpr.DefaultBroadcasterFactory 11:17:41.060 [INFO ] [sphere.cpr.AtmosphereFramework:715 ] - Using WebSocketProcessor: org.atmosphere.websocket.DefaultWebSocketProcessor 11:17:41.079 [INFO ] [sphere.cpr.AtmosphereFramework:716 ] - Using Broadcaster: org.atmosphere.jersey.JerseyBroadcaster 11:17:41.122 [INFO ] [sphere.cpr.AtmosphereFramework:717 ] - Atmosphere is using async support: org.atmosphere.container.JettyAsyncSupportWithWebSocket running under container: jetty/8.1.3.v20120522 with WebSocket enabled. 11:17:41.239 [INFO ] [sphere.cpr.AtmosphereFramework:719 ] - Atmosphere Framework 2.0.9 started. 11:17:41.250 [INFO ] [sphere.cpr.AtmosphereFramework:721 ] -
For Atmosphere Framework Commercial Support, visit
http://www.async-io.org/ or send an email to support@async-io.org
11:17:41.282 [INFO ] [penhab.io.rest.RESTApplication:143 ] - Started REST API at /rest 11:17:41.346 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-server._tcp.local. at port 8080 11:17:42.356 [INFO ] [sphere.cpr.AtmosphereFramework:774 ] - Latest version of Atmosphere's JavaScript Client 2.0.9 11:17:42.362 [INFO ] [sphere.cpr.AtmosphereFramework:781 ] -
Atmosphere Framework Updates
Minor available (bugs fixes): 2.0.10
Major available (new features): 2.1.11
11:17:44.131 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443 11:17:47.772 [INFO ] [.o.u.w.i.servlet.WebAppServlet:79 ] - Started Classic UI at /openhab.app 11:17:54.497 [DEBUG] [.r.internal.RuleModelActivator:42 ] - Registered 'rules' configuration parser 11:17:54.894 [DEBUG] [m.r.internal.engine.RuleEngine:78 ] - Started rule engine 11:17:59.364 [INFO ] [c.internal.ModelRepositoryImpl:79 ] - Loading model 'test.rules' 11:18:40.112 [DEBUG] [o.b.m.internal.ModbusActivator:30 ] - Modbus binding has been started. 11:18:40.960 [DEBUG] [.sonos.internal.SonosActivator:38 ] - Sonos binding bundle has been started. 11:18:41.601 [INFO ] [.service.AbstractActiveService:169 ] - Sonos Refresh Service has been started 11:18:42.041 [DEBUG] [.a.mail.internal.MailActivator:34 ] - Mail action has been started. 11:18:42.593 [DEBUG] [b.f.internal.FritzboxActivator:30 ] - Fritzbox binding has been started. 11:18:43.058 [INFO ] [g.teleal.cling.UpnpServiceImpl:68 ] - >>> Starting UPnP service... 11:18:43.074 [INFO ] [g.teleal.cling.UpnpServiceImpl:70 ] - Using configuration: org.openhab.binding.sonos.internal.SonosBinding$SonosUpnpServiceConfiguration 11:18:43.110 [INFO ] [.service.AbstractActiveService:169 ] - FritzBox refresh Service has been started 11:18:43.690 [DEBUG] [i.t.TTSServiceSpeechDispatcher:45 ] - Activate 11:18:44.084 [DEBUG] [.a.xbmc.internal.XBMCActivator:34 ] - XBMC action has been started. 11:18:44.343 [INFO ] [.teleal.cling.transport.Router:87 ] - Creating Router: org.teleal.cling.transport.RouterImpl 11:18:44.906 [DEBUG] [.o.b.d.i.DigitalSTROMActivator:32 ] - digitalSTROM binding has been started. 11:18:45.633 [DEBUG] [.o.internal.OpenWebIfActivator:33 ] - OpenWebIf action has been started. 11:18:46.153 [DEBUG] [b.p.internal.PlugwiseActivator:33 ] - Plugwise binding has been started. 11:18:46.889 [INFO ] [ing.transport.spi.StreamServer:82 ] - Created socket (for receiving TCP streams) on: /192.168.2.110:50021 11:18:46.913 [INFO ] [ing.transport.spi.StreamServer:82 ] - Created socket (for receiving TCP streams) on: /192.168.2.111:46888 11:18:46.964 [INFO ] [o.t.c.t.spi.MulticastReceiver :72 ] - Creating wildcard socket (for receiving multicast datagrams) on port: 1900 11:18:46.987 [INFO ] [o.t.c.t.spi.MulticastReceiver :79 ] - Joining multicast group: /239.255.255.250:1900 on network interface: wlan0 11:18:47.023 [DEBUG] [.prowl.internal.ProwlActivator:34 ] - Prowl action has been started. 11:18:47.034 [INFO ] [o.t.c.t.spi.MulticastReceiver :72 ] - Creating wildcard socket (for receiving multicast datagrams) on port: 1900 11:18:47.068 [INFO ] [o.t.c.t.spi.MulticastReceiver :79 ] - Joining multicast group: /239.255.255.250:1900 on network interface: eth0 11:18:47.123 [INFO ] [cling.transport.spi.DatagramIO:85 ] - Creating bound socket (for datagram input/output) on: /192.168.2.110 11:18:47.190 [INFO ] [cling.transport.spi.DatagramIO:85 ] - Creating bound socket (for datagram input/output) on: /192.168.2.111 11:18:47.258 [INFO ] [g.teleal.cling.UpnpServiceImpl:85 ] - <<< UPnP service started successfully 11:18:47.294 [INFO ] [.b.sonos.internal.SonosBinding:768 ] - Querying the network for any other Sonos device 11:18:47.412 [DEBUG] [a.p.internal.PushoverActivator:35 ] - Pushover action has been started. 11:18:47.476 [DEBUG] [.o.a.p.i.PushoverActionService:90 ] - Pushover action service activated 11:18:47.520 [DEBUG] [.o.a.p.i.PushoverActionService:112 ] - Configuration file is being parsed. 11:18:47.536 [DEBUG] [.o.a.p.i.PushoverActionService:178 ] - The configurations information was empty. No defaults for Pushover loaded. 11:18:48.637 [DEBUG] [.b.internal.BluetoothActivator:32 ] - Bluetooth binding has been started. 11:18:52.904 [DEBUG] [.b.e.i.EpsonProjectorActivator:34 ] - Epson projector binding has been started. 11:18:53.419 [DEBUG] [.o.b.e.i.EpsonProjectorBinding:78 ] - Activate 11:18:53.464 [DEBUG] [.o.b.e.i.EpsonProjectorBinding:544 ] - Configuration updated, config false 11:18:54.161 [ERROR] [b.b.i.BTDeviceDiscoveryService:217 ] - 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] 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] 11:18:54.823 [DEBUG] [.o.b.tcp.internal.TCPActivator:35 ] - TCP/UDP binding has been started. 11:18:55.421 [INFO ] [t.AbstractSocketChannelBinding:768 ] - The maximum buffer will be set to the default value of 1024 11:18:55.429 [INFO ] [t.AbstractSocketChannelBinding:775 ] - The interval to retry connection setups will be set to the default value of 5 11:18:55.479 [INFO ] [t.AbstractSocketChannelBinding:782 ] - The cron job to reset connections will be set to the default value of 0 0 0 * * ? 11:18:55.491 [INFO ] [t.AbstractSocketChannelBinding:789 ] - The setting to queue write operation until a channel gets connected will be set to the default value of true 11:18:55.519 [INFO ] [t.AbstractSocketChannelBinding:796 ] - The port to listen for incoming connections will be set to the default value of 0 11:18:55.556 [INFO ] [t.AbstractSocketChannelBinding:803 ] - The setting to share channels within an Item will be set to the default value of true 11:18:55.574 [INFO ] [t.AbstractSocketChannelBinding:810 ] - The setting to share channels between the items with the same direction will be set to the default value of true 11:18:55.600 [INFO ] [t.AbstractSocketChannelBinding:817 ] - The setting to share channels between directions will be set to the default value of true 11:18:55.618 [INFO ] [t.AbstractSocketChannelBinding:824 ] - The setting to use address masks for incoming connections will be set to the default value of true 11:18:55.697 [INFO ] [t.protocol.internal.TCPBinding:171 ] - The maximum time out for blocking write operations will be set to the default vaulue of 3000 11:18:55.710 [INFO ] [.service.AbstractActiveService:169 ] - TCP Refresh Service has been started 11:18:55.724 [INFO ] [t.protocol.internal.TCPBinding:178 ] - The blocking nature of read/write operations will be set to the default vaulue of false 11:18:55.753 [INFO ] [t.protocol.internal.TCPBinding:190 ] - The preamble for all write operations will be set to the default vaulue of 11:18:55.810 [INFO ] [t.protocol.internal.TCPBinding:202 ] - The postamble for all write operations will be set to the default vaulue of
11:18:55.845 [INFO ] [t.protocol.internal.TCPBinding:209 ] - Updating states with returned values will be set to the default vaulue of true 11:18:55.870 [INFO ] [t.protocol.internal.TCPBinding:216 ] - The characterset will be set to the default vaulue of ASCII 11:18:56.951 [DEBUG] [.urtsi.internal.UrtsiActivator:32 ] - Somfy URTSI II binding has been started. 11:18:57.883 [DEBUG] [h.internal.HDanywhereActivator:33 ] - HDanywhere binding has been started. 11:18:58.344 [WARN ] [.c.p.RetrieveRemoteDescriptors:138 ] - Received device descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml 11:18:58.960 [INFO ] [.service.AbstractActiveService:169 ] - HDanywhere Refresh Service has been started 11:19:00.074 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Synology Inc DS214+ 11:19:00.081 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Synology DS214+ DS214+ 5.2-5565 11:19:00.080 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: ONKYO TX-NR609 11:19:00.387 [WARN ] [.c.p.RetrieveRemoteDescriptors:272 ] - Received service descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/dummy.xml 11:19:00.504 [WARN ] [.c.p.RetrieveRemoteDescriptors:278 ] - Received empty descriptor:http://192.168.2.4:5000/ssdp/dummy.xml 11:19:00.549 [WARN ] [.c.p.RetrieveRemoteDescriptors:166 ] - Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:00.665 [DEBUG] [.b.sonos.internal.SonosBinding:188 ] - Discovery failed: Synology DS214+ DS214+ 5.2-5565 => org.teleal.cling.binding.xml.DescriptorBindingException: Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:00.987 [DEBUG] [.a.xmpp.internal.XMPPActivator:34 ] - XMPP action has been started. 11:19:03.681 [INFO ] [.b.sonos.internal.SonosBinding:227 ] - A non-Sonos device (Synology Inc DS214+) is found and will be ignored 11:19:03.845 [INFO ] [.b.sonos.internal.SonosBinding:227 ] - A non-Sonos device (ONKYO TX-NR609) is found and will be ignored 11:19:04.631 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:04.756 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:05.174 [DEBUG] [b.a.internal.AsteriskActivator:30 ] - Asterisk binding has been started. 11:19:05.655 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:254e9977-8964-49f3-b8d5-51acb7bd40fc, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:05.720 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:06.685 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:06.709 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:07.253 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:9f0865b3-f5da-4ad5-85b7-7404637fdf37, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:07.265 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:11.607 [DEBUG] [o.b.s.internal.SerialActivator:31 ] - Serial binding has been started. 11:19:12.031 [DEBUG] [.b.n.internal.NetatmoActivator:42 ] - Netatmo binding has been started. 11:19:12.496 [DEBUG] [o.b.r.internal.RFXComActivator:34 ] - RFXCOM binding has been started. 11:19:12.973 [DEBUG] [.b.r.internal.RFXComConnection:49 ] - Activate 11:19:12.981 [DEBUG] [.b.r.internal.RFXComConnection:75 ] - Configuration updated, config false 11:19:13.305 [DEBUG] [.rfxcom.internal.RFXComBinding:60 ] - Activate 11:19:13.895 [DEBUG] [hab.io.cv.internal.CVActivator:32 ] - Cometvisu API has been started. 11:19:14.087 [INFO ] [.a.core.PackagesResourceConfig:101 ] - Scanning for root resource and provider classes in the packages: org.openhab.io.cv.internal.resources 11:19:14.359 [INFO ] [.a.core.ScanningResourceConfig:153 ] - Root resource classes found: class org.openhab.io.cv.internal.resources.WriteResource class org.openhab.io.cv.internal.resources.RrdResource class org.openhab.io.cv.internal.resources.ReadResource class org.openhab.io.cv.internal.resources.LoginResource 11:19:14.370 [INFO ] [.a.core.ScanningResourceConfig:94 ] - No provider classes found. 11:19:14.541 [INFO ] [sphere.cpr.AtmosphereFramework:2175 ] - Atmosphere is using org.atmosphere.cpr.DefaultAnnotationProcessor for processing annotation 11:19:14.545 [INFO ] [cpr.DefaultAnnotationProcessor:131 ] - AnnotationProcessor class org.atmosphere.cpr.DefaultAnnotationProcessor$BytecodeBasedAnnotationProcessor being used 11:19:15.666 [ERROR] [sphere.cpr.AtmosphereFramework:2215 ] - java.lang.ClassCastException: org.eclipse.osgi.framework.internal.core.BundleURLConnection cannot be cast to java.net.JarURLConnection at org.atmosphere.util.annotation.AnnotationDetector.detect(AnnotationDetector.java:325) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.DefaultAnnotationProcessor.scanForAnnotation(DefaultAnnotationProcessor.java:148) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.DefaultAnnotationProcessor.configure(DefaultAnnotationProcessor.java:134) ~[atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.autoConfigureService(AtmosphereFramework.java:2177) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:655) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereFramework.init(AtmosphereFramework.java:568) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereServlet.configureFramework(AtmosphereServlet.java:91) [atmosphere-runtime-2.0.9.jar:2.0.9] at org.atmosphere.cpr.AtmosphereServlet.init(AtmosphereServlet.java:80) [atmosphere-runtime-2.0.9.jar:2.0.9] 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.cv.CVApplication.activate(CVApplication.java:142) [bundlefile:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0] at java.lang.reflect.Method.invoke(Method.java:483) ~[na:1.8.0] 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] 11:19:15.804 [INFO ] [sphere.cpr.AtmosphereFramework:1506 ] - Auto detecting atmosphere handlers /WEB-INF/classes/ 11:19:15.925 [WARN ] [sphere.cpr.AtmosphereFramework:1154 ] - Missing META-INF/atmosphere.xml but found the Jersey runtime. Starting Jersey 11:19:15.956 [INFO ] [sphere.cpr.AtmosphereFramework:434 ] - Installed AtmosphereHandler org.atmosphere.handler.ReflectorServletProcessor mapped to context-path: /* 11:19:15.987 [INFO ] [sphere.cpr.AtmosphereFramework:1561 ] - Auto detecting WebSocketHandler in /WEB-INF/classes/ 11:19:16.050 [INFO ] [sphere.cpr.AtmosphereFramework:1259 ] - Installed WebSocketProtocol org.atmosphere.websocket.protocol.SimpleHttpProtocol 11:19:16.247 [INFO ] [.a.h.ReflectorServletProcessor:140 ] - Installing Servlet com.sun.jersey.spi.container.servlet.ServletContainer 11:19:16.547 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:790 ] - Initiating Jersey application, version 'Jersey: 1.17.1 02/28/2013 12:47 PM' 11:19:16.611 [INFO ] [c.s.j.s.i.a.WebApplicationImpl:801 ] - Adding the following classes declared in META-INF/services/jersey-server-components to the resource configuration: class org.atmosphere.jersey.AtmosphereResourceConfigurator 11:19:17.526 [INFO ] [.a.core.PackagesResourceConfig:101 ] - Scanning for root resource and provider classes in the packages: org.openhab.io.cv.internal.resources 11:19:17.539 [INFO ] [.a.core.ScanningResourceConfig:153 ] - Root resource classes found: class org.openhab.io.cv.internal.resources.WriteResource class org.openhab.io.cv.internal.resources.RrdResource class org.openhab.io.cv.internal.resources.ReadResource class org.openhab.io.cv.internal.resources.LoginResource 11:19:17.553 [INFO ] [.a.core.ScanningResourceConfig:94 ] - No provider classes found. 11:19:18.123 [INFO ] [j.s.i.a.DeferredResourceConfig:101 ] - Instantiated the Application class org.openhab.io.cv.CVApplication 11:19:25.187 [WARN ] [.c.p.RetrieveRemoteDescriptors:138 ] - Received device descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml 11:19:25.465 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:25.499 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Synology DS214+ DS214+ 5.2-5565 11:19:25.565 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:25.638 [WARN ] [.c.p.RetrieveRemoteDescriptors:272 ] - Received service descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/dummy.xml 11:19:25.740 [WARN ] [.c.p.RetrieveRemoteDescriptors:278 ] - Received empty descriptor:http://192.168.2.4:5000/ssdp/dummy.xml 11:19:25.780 [WARN ] [.c.p.RetrieveRemoteDescriptors:166 ] - Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:25.884 [DEBUG] [.b.sonos.internal.SonosBinding:188 ] - Discovery failed: Synology DS214+ DS214+ 5.2-5565 => org.teleal.cling.binding.xml.DescriptorBindingException: Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:26.062 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:26.083 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:27.387 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:27.406 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:9f0865b3-f5da-4ad5-85b7-7404637fdf37, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:27.434 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:27.449 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:27.829 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:254e9977-8964-49f3-b8d5-51acb7bd40fc, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:27.917 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:28.749 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:9f0865b3-f5da-4ad5-85b7-7404637fdf37, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:28.756 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:31.033 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Default Response's Headers Interceptor with priority AFTER_DEFAULT 11:19:31.050 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Android Interceptor Support with priority AFTER_DEFAULT 11:19:31.062 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor SSE Interceptor Support with priority AFTER_DEFAULT 11:19:31.083 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor JSONP Interceptor Support with priority AFTER_DEFAULT 11:19:31.093 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Atmosphere JavaScript Protocol with priority AFTER_DEFAULT 11:19:31.103 [INFO ] [sphere.cpr.AtmosphereFramework:2014 ] - Installed AtmosphereInterceptor Browser disconnection detection with priority AFTER_DEFAULT 11:19:31.114 [INFO ] [sphere.cpr.AtmosphereFramework:826 ] - Installing Default AtmosphereInterceptor 11:19:31.128 [WARN ] [sphere.cpr.AtmosphereFramework:703 ] - No BroadcasterCache configured. Broadcasted message between client reconnection will be LOST. It is recommended to configure the org.atmosphere.cache.UUIDBroadcasterCache 11:19:31.153 [INFO ] [sphere.cpr.AtmosphereFramework:711 ] - Broadcaster Polling Wait Time 100 11:19:31.161 [INFO ] [sphere.cpr.AtmosphereFramework:712 ] - Shared ExecutorService supported: true 11:19:31.174 [INFO ] [sphere.cpr.AtmosphereFramework:713 ] - HttpSession supported: false 11:19:31.189 [INFO ] [sphere.cpr.AtmosphereFramework:714 ] - Using BroadcasterFactory: org.atmosphere.cpr.DefaultBroadcasterFactory 11:19:31.198 [INFO ] [sphere.cpr.AtmosphereFramework:715 ] - Using WebSocketProcessor: org.atmosphere.websocket.DefaultWebSocketProcessor 11:19:31.209 [INFO ] [sphere.cpr.AtmosphereFramework:716 ] - Using Broadcaster: org.atmosphere.jersey.JerseyBroadcaster 11:19:31.220 [INFO ] [sphere.cpr.AtmosphereFramework:717 ] - Atmosphere is using async support: org.atmosphere.container.JettyAsyncSupportWithWebSocket running under container: jetty/8.1.3.v20120522 with WebSocket enabled. 11:19:31.226 [INFO ] [sphere.cpr.AtmosphereFramework:719 ] - Atmosphere Framework 2.0.9 started. 11:19:31.232 [INFO ] [sphere.cpr.AtmosphereFramework:721 ] -
For Atmosphere Framework Commercial Support, visit
http://www.async-io.org/ or send an email to support@async-io.org
11:19:31.239 [INFO ] [rg.openhab.io.cv.CVApplication:145 ] - Started Cometvisu API at /services/cv 11:19:31.247 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-cv-server._tcp.local. at port 8080 11:19:31.745 [INFO ] [sphere.cpr.AtmosphereFramework:774 ] - Latest version of Atmosphere's JavaScript Client 2.0.9 11:19:31.749 [INFO ] [sphere.cpr.AtmosphereFramework:781 ] -
Atmosphere Framework Updates
Minor available (bugs fixes): 2.0.10
Major available (new features): 2.1.11
11:19:33.847 [DEBUG] [o.o.i.s.i.DiscoveryServiceImpl:66 ] - Registering new service _openhab-cv-server-ssl._tcp.local. at port 8443 11:19:36.769 [DEBUG] [.i.d.internal.DropboxActivator:33 ] - Dropbox IO Bundle has been started. 11:19:37.715 [DEBUG] [.h.internal.HomematicActivator:33 ] - Homematic action has been started. 11:19:38.363 [DEBUG] [b.n.internal.HeatPumpActivator:38 ] - Novelan HeatPump binding has been started. 11:19:39.139 [DEBUG] [a.n.i.NotifyMyAndroidActivator:34 ] - NotifyMyAndroid action has been started. 11:19:39.162 [DEBUG] [i.NotifyMyAndroidActionService:73 ] - NotifyMyAndroid action service activated 11:19:39.177 [DEBUG] [i.NotifyMyAndroidActionService:96 ] - Updating config 11:19:39.195 [DEBUG] [i.NotifyMyAndroidActionService:131 ] - Dictionary was NULL, didn't read any configuration 11:19:39.499 [DEBUG] [.o.b.rme.internal.RMEActivator:38 ] - RME binding has been started. 11:19:39.706 [INFO ] [.service.AbstractActiveService:169 ] - RME Refresh Service has been started 11:19:40.129 [DEBUG] [.b.o.internal.OceanicActivator:38 ] - Oceanic binding has been started. 11:19:40.310 [INFO ] [.service.AbstractActiveService:169 ] - Oceanic Refresh Service has been started 11:19:41.068 [DEBUG] [o.o.b.t.i.TinkerforgeActivator:34 ] - Tinkerforge binding has been started. 11:19:41.763 [DEBUG] [.b.m.internal.MaxCubeActivator:30 ] - MAX!Cube LAN gateway binding has been started. 11:19:42.077 [DEBUG] [.a.t.internal.TwitterActivator:34 ] - Twitter action has been started. 11:19:43.664 [DEBUG] [.b.wemo.internal.WemoActivator:34 ] - Wemo binding has been started. 11:19:44.034 [DEBUG] [.o.b.wemo.internal.WemoBinding:144 ] - wemoDiscovery() is called! 11:19:44.065 [DEBUG] [.o.b.wemo.internal.WemoBinding:170 ] - Request: M-SEARCH * HTTP/1.1 HOST: 239.255.255.250:1900 ST: urn:Belkin:device: MAN: "ssdp:discover" MX: 5
11:19:44.078 [DEBUG] [.o.b.wemo.internal.WemoBinding:180 ] - Source-Address = 'raspberrypi/127.0.1.1:1901' 11:19:44.092 [DEBUG] [.o.b.wemo.internal.WemoBinding:182 ] - Send multicast request. 11:19:44.104 [DEBUG] [.o.b.wemo.internal.WemoBinding:185 ] - Multicast ends. Close connection. 11:19:44.118 [DEBUG] [.o.b.wemo.internal.WemoBinding:196 ] - Send datagram packet. 11:19:44.145 [DEBUG] [.o.b.wemo.internal.WemoBinding:201 ] - Receive SSDP Message. 11:19:46.160 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:46.165 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:46.352 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:46.362 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:46.699 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:46.785 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:47.056 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:9f0865b3-f5da-4ad5-85b7-7404637fdf37, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:47.063 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:47.573 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:565aa949-67c1-4c0e-aa8f-f349e6f59311, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:19:47.608 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:48.322 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:48.601 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:49.140 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:254e9977-8964-49f3-b8d5-51acb7bd40fc, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:49.150 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:49.200 [DEBUG] [.o.b.wemo.internal.WemoBinding:230 ] - Message receive timed out. 11:19:49.505 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:565aa949-67c1-4c0e-aa8f-f349e6f59311, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:19:49.538 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:19:49.695 [INFO ] [insteonplm.InsteonPLMActivator:34 ] - Insteon PLM binding has been started. 11:19:50.184 [DEBUG] [.o.b.i.InsteonPLMActiveBinding:152 ] - activating binding 11:19:50.278 [DEBUG] [.s.internal.SamsungTvActivator:34 ] - Samsung TV binding has been started. 11:19:51.222 [DEBUG] [b.k.internal.KoubachiActivator:34 ] - Koubachi binding has been started. 11:19:51.990 [DEBUG] [.b.e.internal.EHealthActivator:33 ] - Libelium eHealth binding has been started. 11:19:52.754 [DEBUG] [.b.fs20.internal.FS20Activator:34 ] - FS20 binding has been started. 11:19:53.083 [DEBUG] [.io.transport.cul.CULActivator:35 ] - CUL transport has been started. 11:19:53.185 [DEBUG] [.o.io.transport.cul.CULManager:133 ] - Registering class org.openhab.io.transport.cul.internal.CULSerialHandlerImpl for device type serial 11:19:53.208 [DEBUG] [.o.io.transport.cul.CULManager:133 ] - Registering class org.openhab.io.transport.cul.internal.CULNetworkHandlerImpl for device type network 11:19:53.319 [DEBUG] [.o.b.fs20.internal.FS20Binding:65 ] - Activating FS20 binding 11:19:53.444 [DEBUG] [.o.internal.OpenPathsActivator:33 ] - OpenPaths binding has been started. 11:19:55.123 [DEBUG] [.b.f.internal.FreeboxActivator:35 ] - Freebox binding has been started. 11:19:55.579 [DEBUG] [.davis.internal.DavisActivator:34 ] - Davis binding has been started. 11:19:56.170 [DEBUG] [inding.em.internal.EMActivator:34 ] - EM binding has been started. 11:19:56.920 [DEBUG] [.b.http.internal.HttpActivator:34 ] - HTTP binding has been started. 11:19:57.431 [INFO ] [.service.AbstractActiveService:169 ] - HTTP Refresh Service has been started 11:19:57.538 [DEBUG] [o.b.h.i.bus.HomematicActivator:33 ] - Homematic binding has been started. 11:19:58.570 [WARN ] [.c.p.RetrieveRemoteDescriptors:138 ] - Received device descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml 11:19:59.020 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Synology DS214+ DS214+ 5.2-5565 11:19:59.618 [WARN ] [.c.p.RetrieveRemoteDescriptors:272 ] - Received service descriptor without or with invalid Content-Type: http://192.168.2.4:5000/ssdp/dummy.xml 11:19:59.684 [WARN ] [.c.p.RetrieveRemoteDescriptors:278 ] - Received empty descriptor:http://192.168.2.4:5000/ssdp/dummy.xml 11:19:59.738 [WARN ] [.c.p.RetrieveRemoteDescriptors:166 ] - Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:59.780 [DEBUG] [.b.sonos.internal.SonosBinding:188 ] - Discovery failed: Synology DS214+ DS214+ 5.2-5565 => org.teleal.cling.binding.xml.DescriptorBindingException: Device service description failed: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:73796E6F-6473-6D00-0000-001132270b51, Descriptor: http://192.168.2.4:5000/ssdp/desc-DSM-eth0.xml, Root: true 11:19:59.930 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Arcadyan, Inc. ARV752DPW 30.05.225 11:20:00.226 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Arcadyan, Inc. ARV752DPW 30.05.225 11:20:00.243 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Arcadyan, Inc. ARV752DPW 30.05.225 11:20:00.254 [DEBUG] [.b.sonos.internal.SonosBinding:183 ] - Discovery started: Arcadyan, Inc. ARV752DPW 30.05.225 11:20:01.269 [INFO ] [.b.sonos.internal.SonosBinding:227 ] - A non-Sonos device (Arcadyan, Inc. ARV752DPW 30.05.225) is found and will be ignored 11:20:01.725 [DEBUG] [b.e.internal.EcoTouchActivator:34 ] - EcoTouch binding has been started. 11:20:03.560 [DEBUG] [p.internal.PioneerAvrActivator:35 ] - pioneeravr binding has been started. 11:20:05.120 [INFO ] [.b.sonos.internal.SonosBinding:227 ] - A non-Sonos device (Arcadyan, Inc. ARV752DPW 30.05.225) is found and will be ignored 11:20:05.660 [DEBUG] [b.p.internal.PioneerAvrBinding:74 ] - Activate 11:20:05.845 [DEBUG] [b.o.internal.OmniLinkActivator:34 ] - OmniLink binding has been started. 11:20:06.445 [DEBUG] [o.b.o.internal.OmniLinkBinding:148 ] - all binding changed 11:20:06.893 [DEBUG] [f.internal.FreeswitchActivator:35 ] - Freeswitch binding has been started. 11:20:07.420 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:20:07.448 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:07.997 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:20:08.078 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:09.161 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:9f0865b3-f5da-4ad5-85b7-7404637fdf37, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:20:09.361 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:10.047 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:060b7353-fca6-4070-85f4-1fbfb9add62c, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:20:10.073 [DEBUG] [.b.e.internal.Enigma2Activator:34 ] - Enigma2 binding has been started. 11:20:10.076 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:10.108 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:565aa949-67c1-4c0e-aa8f-f349e6f59311, Descriptor: http://192.168.2.3:1900/igd.xml, Root: true 11:20:10.186 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:10.370 [WARN ] [.c.p.RetrieveRemoteDescriptors:191 ] - Could not hydrate device or its services from descriptor: (RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:565aa949-67c1-4c0e-aa8f-f349e6f59311, Descriptor: http://192.168.2.2:1900/igd.xml, Root: true 11:20:10.385 [WARN ] [.c.p.RetrieveRemoteDescriptors:192 ] - Cause was: org.teleal.cling.binding.xml.DescriptorBindingException: Invalid URLBase: no protocol: 11:20:11.227 [DEBUG] [.a.internal.bus.AstroActivator:32 ] - Astro binding has been started. 11:20:11.785 [DEBUG] [b.f.internal.FritzahaActivator:33 ] - Fritz AVM Home Automation binding has been started. 11:20:13.040 [DEBUG] [xDBPersistenceServiceActivator:27 ] - InfluxDB persistence bundle has been started. 11:20:13.333 [DEBUG] [i.i.InfluxDBPersistenceService:93 ] - influxdb persistence service activated 11:20:13.405 [DEBUG] [.p.internal.PersistenceManager:146 ] - Initializing influxdb persistence service. 11:20:13.504 [DEBUG] [c.internal.ModelRepositoryImpl:63 ] - Configuration model 'influxdb.persist' can not be found 11:20:13.795 [DEBUG] [.b.snmp.internal.SnmpActivator:35 ] - SNMP binding has been started. 11:20:14.458 [DEBUG] [.o.b.snmp.internal.SnmpBinding:90 ] - SNMP binding activated 11:20:14.470 [INFO ] [.service.AbstractActiveService:169 ] - SNMP Refresh Service has been started 11:20:14.560 [DEBUG] [xecPersistenceServiceActivator:33 ] - Exec persistence bundle has been started. 11:20:14.854 [DEBUG] [.p.internal.PersistenceManager:146 ] - Initializing exec persistence service. 11:20:15.432 [DEBUG] [.p.internal.PersistenceManager:428 ] - Scheduled strategy exec.everyMinute with cron expression 0 * * * * ? 11:20:15.492 [DEBUG] [b.c.internal.ComfoAirActivator:34 ] - ComfoAir binding has been started. 11:20:16.165 [DEBUG] [.sense.internal.SenseActivator:31 ] - Open.Sen.se persistence bundle has been started. 11:20:16.506 [DEBUG] [.p.internal.PersistenceManager:146 ] - Initializing sense persistence service. 11:20:16.531 [DEBUG] [c.internal.ModelRepositoryImpl:63 ] - Configuration model 'sense.persist' can not be found 11:20:19.288 [DEBUG] [JpaPersistenceServiceActivator:31 ] - JPA persistence bundle has been started. 11:20:19.644 [DEBUG] [.o.p.j.i.JpaPersistenceService:59 ] - Activating jpa binding... 11:20:19.659 [DEBUG] [.o.p.j.i.JpaPersistenceService:60 ] - Activating jpa binding...done 11:20:19.666 [DEBUG] [.p.internal.PersistenceManager:146 ] - Initializing jpa persistence service. 11:20:19.676 [DEBUG] [c.internal.ModelRepositoryImpl:63 ] - Configuration model 'jpa.persist' can not be found 11:20:20.231 [DEBUG] [.o.b.n.internal.NikobusBinding:71 ] - Started Command Receiver Thread. 11:20:20.255 [DEBUG] [.o.b.n.internal.NikobusBinding:78 ] - Started Command Sender Thread. 11:20:20.268 [DEBUG] [.n.i.core.NikobusCommandSender:48 ] - Command sender started. 11:20:20.336 [DEBUG] [.o.b.n.internal.NikobusBinding:307 ] - Refresh service started. Will refresh a module every 600 seconds. 11:20:20.548 [DEBUG] [.m.internal.MqttitudeActivator:33 ] - Mqttitude binding has been started. 11:20:21.111 [DEBUG] [.b.m.internal.MqttitudeBinding:84 ] - Activating Mqttitude binding 11:20:21.202 [DEBUG] [.o.b.n.i.NibeHeatPumpActivator:34 ] - Nibe heatpump binding has been started. 11:20:21.622 [DEBUG] [n.internal.NibeHeatPumpBinding:58 ] - Activate 11:20:21.854 [DEBUG] [o.o.b.w.i.bus.WeatherActivator:32 ] - Weather binding has been started. 11:20:22.326 [DEBUG] [i.internal.GenericItemProvider:334 ] - Start processing binding configuration of Item 'Weather_Temperature_home (Type=NumberItem, State=Uninitialized)' with 'WeatherGenericBindingProvider' reader. 11:20:23.020 [DEBUG] [.WeatherGenericBindingProvider:57 ] - Adding item Weather_Temperature_home with WeatherBindingConfig[locationId=home,type=temperature,property=current,roundingMode=HALF_UP,scale=2] 11:20:23.476 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=current_observation.relative_humidity,target=athmosphere.humidity,converter=PERCENT_INTEGER] 11:20:23.483 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=avehumidity,target=athmosphere.humidity,converter=INTEGER] 11:20:23.491 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=humidity,target=athmosphere.humidity,converter=INTEGER] 11:20:23.673 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=humidity,target=athmosphere.humidity,converter=FRACTION_INTEGER] 11:20:23.733 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WORLDWEATHERONLINE: ProviderMappingInfo[source=humidity,target=athmosphere.humidity,converter=INTEGER] 11:20:23.790 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping YAHOO: ProviderMappingInfo[source=atmosphere.humidity,target=athmosphere.humidity,converter=INTEGER] 11:20:23.813 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping HAMWEATHER: ProviderMappingInfo[source=humidity,target=athmosphere.humidity,converter=INTEGER] 11:20:23.836 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=current_observation.visibility_km,target=athmosphere.visibility,converter=DOUBLE] 11:20:23.850 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=visibility,target=athmosphere.visibility,converter=DOUBLE] 11:20:23.864 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WORLDWEATHERONLINE: ProviderMappingInfo[source=visibility,target=athmosphere.visibility,converter=DOUBLE] 11:20:23.877 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping YAHOO: ProviderMappingInfo[source=atmosphere.visibility,target=athmosphere.visibility,converter=DOUBLE] 11:20:23.894 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping HAMWEATHER: ProviderMappingInfo[source=visibilityKM,target=athmosphere.visibility,converter=DOUBLE] 11:20:24.316 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=current_observation.pressure_mb,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.333 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=pressure,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.366 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=pressure,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.395 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WORLDWEATHERONLINE: ProviderMappingInfo[source=pressure,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.410 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping YAHOO: ProviderMappingInfo[source=atmosphere.pressure,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.422 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping HAMWEATHER: ProviderMappingInfo[source=pressureMB,target=athmosphere.pressure,converter=DOUBLE] 11:20:24.443 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=ozone,target=athmosphere.ozone,converter=INTEGER] 11:20:24.466 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=clouds.all,target=clouds.percent,converter=INTEGER] 11:20:24.491 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=clouds,target=clouds.percent,converter=INTEGER] 11:20:24.500 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=cloudCover,target=clouds.percent,converter=FRACTION_INTEGER] 11:20:24.514 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WORLDWEATHERONLINE: ProviderMappingInfo[source=cloudcover,target=clouds.percent,converter=INTEGER] 11:20:24.531 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping HAMWEATHER: ProviderMappingInfo[source=sky,target=clouds.percent,converter=INTEGER] 11:20:24.555 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=current_observation.weather,target=condition.text,converter=STRING] 11:20:24.569 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=conditions,target=condition.text,converter=STRING] 11:20:24.581 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=weather.description,target=condition.text,converter=STRING] 11:20:24.595 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=summary,target=condition.text,converter=STRING] 11:20:24.607 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WORLDWEATHERONLINE: ProviderMappingInfo[source=weatherDesc.value,target=condition.text,converter=STRING] 11:20:24.614 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping YAHOO: ProviderMappingInfo[source=text,target=condition.text,converter=STRING] 11:20:24.620 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping HAMWEATHER: ProviderMappingInfo[source=weather,target=condition.text,converter=STRING] 11:20:24.650 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=current_observation.observation_epoch,target=condition.observationTime,converter=UNIX_DATE] 11:20:24.666 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping WUNDERGROUND: ProviderMappingInfo[source=date.epoch,target=condition.observationTime,converter=UNIX_DATE] 11:20:24.679 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping OPENWEATHERMAP: ProviderMappingInfo[source=dt,target=condition.observationTime,converter=UNIX_DATE] 11:20:24.690 [TRACE] [b.w.i.metadata.MetadataHandler:87 ] - Added provider mapping FORECASTIO: ProviderMappingInfo[source=time,target=condition.observationTime,converter=UNIX_DATE] 11:20:24.711 [TRACE] [b.w.i.metada
it looks you've copied all bindings to addon the directory. Please only copy those binding jar files you are really going to use in your system …
Hello Teichsta,
yes I copied all bindings. Actually I updated to OpenHab1.7 and only copied the needed bindings!
Now it works!
Thanks for support and help.
The issue can be closed.
Now it works!
great, thanks for this update!
Hello Altogether,
I have setup a WeatherBinding which works fine. Then I added the my.openhab binding/service for remote access.
My problem no is that only one of the two services is running: WeatherBinding is running and my.openhab is not running or WeatherBinding is not running and my.openhab is running
Do I have to configure something special or is this a known issue?
If you need more information let me know.
Thanks so far.
Nice greetings
Gerhard