I changed my IDE to latest one and now I have some OH launching problems. I made some testing with the latest launch configuration from the master.
Almost all the time OH is not started properly.
2016-01-16 14:53:57.853 [DEBUG] [.m.t.r.i.ThingRuntimeActivator:20 ] - Registered 'thing' configuration parser
2016-01-16 14:53:57.923 [DEBUG] [s.m.i.r.i.ItemRuntimeActivator:20 ] - Registered 'item' configuration parser
2016-01-16 14:53:58.123 [DEBUG] [.s.r.i.SitemapRuntimeActivator:20 ] - Registered 'sitemap' configuration parser
2016-01-16 14:53:58.227 [INFO ] [uartz.impl.StdSchedulerFactory:1184 ] - Using default implementation for ThreadExecutor
2016-01-16 14:53:58.270 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2016-01-16 14:53:58.271 [INFO ] [rg.quartz.core.QuartzScheduler:240 ] - Quartz Scheduler v.2.2.1 created.
2016-01-16 14:53:58.272 [INFO ] [org.quartz.simpl.RAMJobStore :155 ] - RAMJobStore initialized.
2016-01-16 14:53:58.274 [INFO ] [rg.quartz.core.QuartzScheduler:305 ] - Scheduler meta-data: Quartz Scheduler (v2.2.1) '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.
2016-01-16 14:53:58.274 [INFO ] [uartz.impl.StdSchedulerFactory:1339 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: 'quartz.properties'
2016-01-16 14:53:58.274 [INFO ] [uartz.impl.StdSchedulerFactory:1343 ] - Quartz scheduler version: 2.2.1
!SESSION 2016-01-16 14:53:55.906 -----------------------------------------------
eclipse.buildId=unknown
java.version=1.8.0_40
java.vendor=Oracle Corporation
BootLoader constants: OS=macosx, ARCH=x86_64, WS=cocoa, NL=en_US
Framework arguments: -application
Command-line arguments: -application -data /Users/Pali/Projects/openhab2-addons/ws/../runtime-org.openhab.runtime.product.product -dev file:/Users/Pali/Projects/openhab2-addons/ws/.metadata/.plugins/org.eclipse.pde.core/openHAB_Runtime/dev.properties -os macosx -ws cocoa -arch x86_64 -consoleLog -console
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:58.278
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = ModelRepository, interface = org.eclipse.smarthome.model.core.ModelRepository, policy = dynamic, cardinality = 0..1, target = null, bind = setModelRepository, unbind = unsetModelRepository]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:58.287
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:58.288
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = ItemRegistry, interface = org.eclipse.smarthome.core.items.ItemRegistry, policy = dynamic, cardinality = 0..1, target = null, bind = setItemRegistry, unbind = unsetItemRegistry]
2016-01-16 14:53:58.373 [DEBUG] [.i.PersistenceRuntimeActivator:20 ] - Registered 'persistence' configuration parser
2016-01-16 14:53:58.963 [DEBUG] [m.s.r.i.ScriptRuntimeActivator:20 ] - Registered 'script' configuration parser
2016-01-16 14:53:59.153 [DEBUG] [s.m.r.r.i.RuleRuntimeActivator:34 ] - Registered 'rule' configuration parser
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.210
!MESSAGE Could not bind a reference of component ConfigDescriptionRegistry. The reference is: Reference[name = ConfigOptionProvider, interface = org.eclipse.smarthome.config.core.ConfigOptionProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigOptionProvider, unbind = removeConfigOptionProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.219
!MESSAGE Could not bind a reference of component ConfigDescriptionRegistry. The reference is: Reference[name = ConfigDescriptionProvider, interface = org.eclipse.smarthome.config.core.ConfigDescriptionProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigDescriptionProvider, unbind = removeConfigDescriptionProvider]
2016-01-16 14:53:59.223 [DEBUG] [.c.t.i.TransformationActivator:34 ] - Transformation Service has been started.
2016-01-16 14:53:59.263 [DEBUG] [.e.s.i.m.i.MultimediaActivator:32 ] - Multimedia I/O bundle has been started.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.418
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.internal.DiscoveryServiceRegistry. The reference is: Reference[name = DiscoveryService, interface = org.eclipse.smarthome.config.discovery.DiscoveryService, policy = dynamic, cardinality = 0..n, target = null, bind = addDiscoveryService, unbind = removeDiscoveryService]
2016-01-16 14:53:59.422 [DEBUG] [s.i.t.m.internal.MDNSActivator:27 ] - mDNS service has been started.
2016-01-16 14:53:59.574 [DEBUG] [.i.r.sse.internal.SseActivator:46 ] - SSE API - SseFeature registered.
2016-01-16 14:53:59.584 [DEBUG] [.i.r.sse.internal.SseActivator:55 ] - SSE API has been started.
2016-01-16 14:53:59.676 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'discovery' of size 5
2016-01-16 14:53:59.681 [DEBUG] [s.c.d.AbstractDiscoveryService:349 ] - Background discovery for discovery service 'org.eclipse.smarthome.binding.ntp.discovery.NtpDiscovery' enabled.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.697
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.ThingRegistry. The reference is: Reference[name = ThingProvider, interface = org.eclipse.smarthome.core.thing.ThingProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.698
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.ThingRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.703
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemChannelLinkRegistry. The reference is: Reference[name = ItemChannelLinkProvider, interface = org.eclipse.smarthome.core.thing.link.ItemChannelLinkProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.704
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemChannelLinkRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.706
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.type.ThingTypeRegistry. The reference is: Reference[name = ThingTypeProvider, interface = org.eclipse.smarthome.core.thing.binding.ThingTypeProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addThingTypeProvider, unbind = removeThingTypeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.720
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemThingLinkRegistry. The reference is: Reference[name = ItemThingLinkProvider, interface = org.eclipse.smarthome.core.thing.link.ItemThingLinkProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:59.720
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemThingLinkRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
2016-01-16 14:53:59.729 [DEBUG] [o.e.s.c.s.i.SchedulerActivator:34 ] - Scheduler has been started.
2016-01-16 14:53:59.731 [INFO ] [rg.quartz.core.QuartzScheduler:575 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
2016-01-16 14:53:59.924 [DEBUG] [.e.s.c.a.i.AutoUpdateActivator:29 ] - AutoUpdate binding has been started.
osgi> 2016-01-16 14:54:00.164 [DEBUG] [.s.s.mapdb.MapDbStorageService:50 ] - Opened MapDB file at '/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/userdata/mapdb/storage.mapdb'.
2016-01-16 14:54:00.211 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.ManagedThingProvider' has been added.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.216
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.inbox.Inbox. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.239
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.internal.console.InboxConsoleCommandExtension. The reference is: Reference[name = ThingSetupManager, interface = org.eclipse.smarthome.core.thing.setup.ThingSetupManager, policy = dynamic, cardinality = 0..1, target = null, bind = setThingSetupManager, unbind = unsetThingSetupManager]
2016-01-16 14:54:00.256 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemChannelLinkProvider' has been added.
2016-01-16 14:54:00.259 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemThingLinkProvider' has been added.
2016-01-16 14:54:00.556 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:54:00.573 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.hue'.
2016-01-16 14:54:00.574 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.eclipse.smarthome.binding.ntp'...
2016-01-16 14:54:00.575 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.ntp'.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.657
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.actionservicefactory. The reference is: Reference[name = ActionService, interface = org.openhab.core.scriptengine.action.ActionService, policy = dynamic, cardinality = 0..n, target = null, bind = addActionService, unbind = removeActionService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.666
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.autoupdateproviderdelegate. The reference is: Reference[name = AutoUpdateBindingProvider, interface = org.openhab.core.autoupdate.AutoUpdateBindingProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addAutoUpdateBindingProvider, unbind = removeAutoUpdateBindingProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.669
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.bindingconfigreaderfactory. The reference is: Reference[name = BindingConfigReader, interface = org.openhab.model.item.binding.BindingConfigReader, policy = dynamic, cardinality = 0..n, target = null, bind = addBindingConfigReader, unbind = removeBindingConfigReader]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.672
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.chartproviderfactory. The reference is: Reference[name = ChartProvider, interface = org.openhab.ui.chart.ChartProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addChartProvider, unbind = removeChartProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.675
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.persistenceservicefactory. The reference is: Reference[name = PersistenceService, interface = org.openhab.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.676
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.ttsservicefactory. The reference is: Reference[name = TTSService, interface = org.openhab.io.multimedia.tts.TTSService, policy = dynamic, cardinality = 0..n, target = null, bind = addTTSService, unbind = removeTTSService]
2016-01-16 14:54:00.709 [DEBUG] [s.c.d.internal.PersistentInbox:179 ] - Updated discovery result for 'ntp:ntp:local'.
2016-01-16 14:54:00.715 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/config/config.xml' in module 'org.eclipse.smarthome.ui.classic'...
2016-01-16 14:54:00.723 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.ui.classic'.
2016-01-16 14:54:00.743 [DEBUG] [.s.core.internal.CoreActivator:30 ] - Core bundle has been started.
2016-01-16 14:54:00.766 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'ConfigStatusService' with size 5-10
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.767
!MESSAGE Could not bind a reference of component ConfigStatusService. The reference is: Reference[name = ConfigStatusProvider, interface = org.eclipse.smarthome.config.core.status.ConfigStatusProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigStatusProvider, unbind = removeConfigStatusProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.839
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.itemregistry. The reference is: Reference[name = ItemProvider, interface = org.eclipse.smarthome.core.items.ItemProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.868
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.ui. The reference is: Reference[name = ItemUIProvider, interface = org.eclipse.smarthome.ui.items.ItemUIProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addItemUIProvider, unbind = removeItemUIProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:00.869
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.io.rest.sitemap. The reference is: Reference[name = SitemapProvider, interface = org.eclipse.smarthome.model.sitemap.SitemapProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addSitemapProvider, unbind = removeSitemapProvider]
2016-01-16 14:54:00.918 [DEBUG] [.c.thing.internal.ThingManager:561 ] - Thing handler factory 'HueThingHandlerFactory' added
2016-01-16 14:54:00.920 [DEBUG] [.c.thing.internal.ThingManager:561 ] - Thing handler factory 'NtpHandlerFactory' added
2016-01-16 14:54:00.923 [DEBUG] [.c.thing.internal.ThingManager:375 ] - Thing 'samsungtv:tv:0d1cef00_00dc_1000_98a1_1c5a3ea52262' is tracked by ThingManager.
2016-01-16 14:54:00.924 [DEBUG] [.c.thing.internal.ThingManager:472 ] - Not registering a handler at this point since no handler factory for thing 'samsungtv:tv:0d1cef00_00dc_1000_98a1_1c5a3ea52262' found.
2016-01-16 14:54:00.976 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.items.ManagedItemProvider' has been added.
2016-01-16 14:54:00.979 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'safeCall' with size 5-10
2016-01-16 14:54:00.981 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'samsungtv_tv_0d1cef00_00dc_1000_98a1_1c5a3ea52262' has been added.
2016-01-16 14:54:01.027 [INFO ] [org.eclipse.jetty.util.log :186 ] - Logging initialized @5447ms
2016-01-16 14:54:01.037 [INFO ] [.DefaultJettyAtJettyHomeHelper:159 ] - Configuring the default jetty server with [file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty.xml, file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty-selector.xml, file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty-deployer.xml]
2016-01-16 14:54:01.037 [INFO ] [.DefaultJettyAtJettyHomeHelper:160 ] - JETTY.HOME=/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/.
2016-01-16 14:54:01.209 [INFO ] [rg.eclipse.jetty.server.Server:327 ] - jetty-9.2.12.v20150709
2016-01-16 14:54:01.231 [WARN ] [.j.s.handler.RequestLogHandler:137 ] - !RequestLog
2016-01-16 14:54:01.477 [INFO ] [e.jetty.server.ServerConnector:266 ] - Started 0.0.0.0:8443@78caa33a{SSL-http/1.1}{0.0.0.0:8443}
2016-01-16 14:54:01.479 [INFO ] [e.jetty.server.ServerConnector:266 ] - Started ServerConnector@1976d89{HTTP/1.1}{0.0.0.0:8080}
2016-01-16 14:54:01.479 [INFO ] [rg.eclipse.jetty.server.Server:379 ] - Started @5901ms
2016-01-16 14:54:01.483 [INFO ] [.DefaultJettyAtJettyHomeHelper:180 ] - Default jetty server configured
2016-01-16 14:54:01.617 [INFO ] [s.ui.paper.internal.PaperUIApp:31 ] - Started Paper UI at /ui
2016-01-16 14:54:01.628 [INFO ] [.u.d.internal.DashboardService:55 ] - Started dashboard at /start
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:01.661
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.ui.chart.defaultprovider. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
2016-01-16 14:54:01.662 [DEBUG] [u.i.chart.DefaultChartProvider:97 ] - Starting up default chart provider.
2016-01-16 14:54:01.663 [DEBUG] [ui.internal.chart.ChartServlet:119 ] - Starting up chart servlet at /chart
2016-01-16 14:54:01.667 [DEBUG] [s.ui.icon.internal.IconServlet:76 ] - Starting up icon servlet at /icon
2016-01-16 14:54:01.670 [DEBUG] [o.e.s.u.c.i.servlet.CmdServlet:56 ] - Starting up CMD servlet at /classicui/CMD
2016-01-16 14:54:01.671 [INFO ] [.server.handler.ContextHandler:744 ] - Started o.e.j.s.ServletContextHandler@2b0fce93{/,null,AVAILABLE}
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:54:01.723
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.model.persistence.extensions. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
2016-01-16 14:54:01.760 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'services.cfg'
!ENTRY org.eclipse.equinox.ds 2 0 2016-01-16 14:54:31.800
!MESSAGE [SCR - WorkThread] Timeout occurred! Thread was blocked on processing org.osgi.service.cm.ConfigurationEvent@1acbd2b3
Some times (1 of the 10) OH starts properly.
2016-01-16 14:53:19.824 [DEBUG] [.m.t.r.i.ThingRuntimeActivator:20 ] - Registered 'thing' configuration parser
2016-01-16 14:53:19.886 [DEBUG] [s.m.i.r.i.ItemRuntimeActivator:20 ] - Registered 'item' configuration parser
2016-01-16 14:53:20.052 [DEBUG] [.s.r.i.SitemapRuntimeActivator:20 ] - Registered 'sitemap' configuration parser
2016-01-16 14:53:20.134 [INFO ] [uartz.impl.StdSchedulerFactory:1184 ] - Using default implementation for ThreadExecutor
2016-01-16 14:53:20.153 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2016-01-16 14:53:20.154 [INFO ] [rg.quartz.core.QuartzScheduler:240 ] - Quartz Scheduler v.2.2.1 created.
2016-01-16 14:53:20.156 [INFO ] [org.quartz.simpl.RAMJobStore :155 ] - RAMJobStore initialized.
2016-01-16 14:53:20.157 [INFO ] [rg.quartz.core.QuartzScheduler:305 ] - Scheduler meta-data: Quartz Scheduler (v2.2.1) '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.
2016-01-16 14:53:20.157 [INFO ] [uartz.impl.StdSchedulerFactory:1339 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: 'quartz.properties'
2016-01-16 14:53:20.157 [INFO ] [uartz.impl.StdSchedulerFactory:1343 ] - Quartz scheduler version: 2.2.1
!SESSION 2016-01-16 14:53:17.991 -----------------------------------------------
eclipse.buildId=unknown
java.version=1.8.0_40
java.vendor=Oracle Corporation
BootLoader constants: OS=macosx, ARCH=x86_64, WS=cocoa, NL=en_US
Framework arguments: -application
Command-line arguments: -application -data /Users/Pali/Projects/openhab2-addons/ws/../runtime-org.openhab.runtime.product.product -dev file:/Users/Pali/Projects/openhab2-addons/ws/.metadata/.plugins/org.eclipse.pde.core/openHAB_Runtime/dev.properties -os macosx -ws cocoa -arch x86_64 -consoleLog -console
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:20.161
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = ModelRepository, interface = org.eclipse.smarthome.model.core.ModelRepository, policy = dynamic, cardinality = 0..1, target = null, bind = setModelRepository, unbind = unsetModelRepository]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:20.163
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:20.164
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.persistence.manager. The reference is: Reference[name = ItemRegistry, interface = org.eclipse.smarthome.core.items.ItemRegistry, policy = dynamic, cardinality = 0..1, target = null, bind = setItemRegistry, unbind = unsetItemRegistry]
2016-01-16 14:53:20.243 [DEBUG] [.i.PersistenceRuntimeActivator:20 ] - Registered 'persistence' configuration parser
2016-01-16 14:53:20.846 [DEBUG] [m.s.r.i.ScriptRuntimeActivator:20 ] - Registered 'script' configuration parser
2016-01-16 14:53:21.067 [DEBUG] [s.m.r.r.i.RuleRuntimeActivator:34 ] - Registered 'rule' configuration parser
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.125
!MESSAGE Could not bind a reference of component ConfigDescriptionRegistry. The reference is: Reference[name = ConfigOptionProvider, interface = org.eclipse.smarthome.config.core.ConfigOptionProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigOptionProvider, unbind = removeConfigOptionProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.133
!MESSAGE Could not bind a reference of component ConfigDescriptionRegistry. The reference is: Reference[name = ConfigDescriptionProvider, interface = org.eclipse.smarthome.config.core.ConfigDescriptionProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigDescriptionProvider, unbind = removeConfigDescriptionProvider]
2016-01-16 14:53:21.136 [DEBUG] [.c.t.i.TransformationActivator:34 ] - Transformation Service has been started.
2016-01-16 14:53:21.167 [DEBUG] [.e.s.i.m.i.MultimediaActivator:32 ] - Multimedia I/O bundle has been started.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.315
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.internal.DiscoveryServiceRegistry. The reference is: Reference[name = DiscoveryService, interface = org.eclipse.smarthome.config.discovery.DiscoveryService, policy = dynamic, cardinality = 0..n, target = null, bind = addDiscoveryService, unbind = removeDiscoveryService]
2016-01-16 14:53:21.326 [DEBUG] [s.i.t.m.internal.MDNSActivator:27 ] - mDNS service has been started.
2016-01-16 14:53:21.485 [DEBUG] [.i.r.sse.internal.SseActivator:46 ] - SSE API - SseFeature registered.
2016-01-16 14:53:21.489 [DEBUG] [.i.r.sse.internal.SseActivator:55 ] - SSE API has been started.
2016-01-16 14:53:21.577 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'discovery' of size 5
2016-01-16 14:53:21.583 [DEBUG] [s.c.d.AbstractDiscoveryService:349 ] - Background discovery for discovery service 'org.eclipse.smarthome.binding.ntp.discovery.NtpDiscovery' enabled.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.600
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.ThingRegistry. The reference is: Reference[name = ThingProvider, interface = org.eclipse.smarthome.core.thing.ThingProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.602
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.ThingRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.605
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemChannelLinkRegistry. The reference is: Reference[name = ItemChannelLinkProvider, interface = org.eclipse.smarthome.core.thing.link.ItemChannelLinkProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.606
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemChannelLinkRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.608
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.type.ThingTypeRegistry. The reference is: Reference[name = ThingTypeProvider, interface = org.eclipse.smarthome.core.thing.binding.ThingTypeProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addThingTypeProvider, unbind = removeThingTypeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.623
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemThingLinkRegistry. The reference is: Reference[name = ItemThingLinkProvider, interface = org.eclipse.smarthome.core.thing.link.ItemThingLinkProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:21.623
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.thing.link.ItemThingLinkRegistry. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
2016-01-16 14:53:21.633 [DEBUG] [o.e.s.c.s.i.SchedulerActivator:34 ] - Scheduler has been started.
2016-01-16 14:53:21.636 [INFO ] [rg.quartz.core.QuartzScheduler:575 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
2016-01-16 14:53:21.769 [DEBUG] [.e.s.c.a.i.AutoUpdateActivator:29 ] - AutoUpdate binding has been started.
osgi> 2016-01-16 14:53:21.965 [DEBUG] [.s.s.mapdb.MapDbStorageService:50 ] - Opened MapDB file at '/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/userdata/mapdb/storage.mapdb'.
2016-01-16 14:53:22.023 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.ManagedThingProvider' has been added.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.028
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.inbox.Inbox. The reference is: Reference[name = EventPublisher, interface = org.eclipse.smarthome.core.events.EventPublisher, policy = dynamic, cardinality = 0..1, target = null, bind = setEventPublisher, unbind = unsetEventPublisher]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.045
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.config.discovery.internal.console.InboxConsoleCommandExtension. The reference is: Reference[name = ThingSetupManager, interface = org.eclipse.smarthome.core.thing.setup.ThingSetupManager, policy = dynamic, cardinality = 0..1, target = null, bind = setThingSetupManager, unbind = unsetThingSetupManager]
2016-01-16 14:53:22.063 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemChannelLinkProvider' has been added.
2016-01-16 14:53:22.067 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemThingLinkProvider' has been added.
2016-01-16 14:53:22.365 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:22.384 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.hue'.
2016-01-16 14:53:22.385 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.eclipse.smarthome.binding.ntp'...
2016-01-16 14:53:22.386 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.ntp'.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.465
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.actionservicefactory. The reference is: Reference[name = ActionService, interface = org.openhab.core.scriptengine.action.ActionService, policy = dynamic, cardinality = 0..n, target = null, bind = addActionService, unbind = removeActionService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.477
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.autoupdateproviderdelegate. The reference is: Reference[name = AutoUpdateBindingProvider, interface = org.openhab.core.autoupdate.AutoUpdateBindingProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addAutoUpdateBindingProvider, unbind = removeAutoUpdateBindingProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.480
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.bindingconfigreaderfactory. The reference is: Reference[name = BindingConfigReader, interface = org.openhab.model.item.binding.BindingConfigReader, policy = dynamic, cardinality = 0..n, target = null, bind = addBindingConfigReader, unbind = removeBindingConfigReader]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.482
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.chartproviderfactory. The reference is: Reference[name = ChartProvider, interface = org.openhab.ui.chart.ChartProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addChartProvider, unbind = removeChartProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.486
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.persistenceservicefactory. The reference is: Reference[name = PersistenceService, interface = org.openhab.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.487
!MESSAGE Could not bind a reference of component org.openhab.core.compat1x.ttsservicefactory. The reference is: Reference[name = TTSService, interface = org.openhab.io.multimedia.tts.TTSService, policy = dynamic, cardinality = 0..n, target = null, bind = addTTSService, unbind = removeTTSService]
2016-01-16 14:53:22.536 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/config/config.xml' in module 'org.eclipse.smarthome.ui.classic'...
2016-01-16 14:53:22.549 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.ui.classic'.
2016-01-16 14:53:22.561 [DEBUG] [.s.core.internal.CoreActivator:30 ] - Core bundle has been started.
2016-01-16 14:53:22.593 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'ConfigStatusService' with size 5-10
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.595
!MESSAGE Could not bind a reference of component ConfigStatusService. The reference is: Reference[name = ConfigStatusProvider, interface = org.eclipse.smarthome.config.core.status.ConfigStatusProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addConfigStatusProvider, unbind = removeConfigStatusProvider]
2016-01-16 14:53:22.616 [DEBUG] [s.c.d.internal.PersistentInbox:179 ] - Updated discovery result for 'ntp:ntp:local'.
2016-01-16 14:53:22.625 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'safeCall' with size 5-10
2016-01-16 14:53:22.630 [INFO ] [rthome.event.InboxUpdatedEvent:43 ] - Discovery Result with UID 'ntp:ntp:local' has been updated.
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.694
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.core.itemregistry. The reference is: Reference[name = ItemProvider, interface = org.eclipse.smarthome.core.items.ItemProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addProvider, unbind = removeProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.712
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.ui. The reference is: Reference[name = ItemUIProvider, interface = org.eclipse.smarthome.ui.items.ItemUIProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addItemUIProvider, unbind = removeItemUIProvider]
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:22.713
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.io.rest.sitemap. The reference is: Reference[name = SitemapProvider, interface = org.eclipse.smarthome.model.sitemap.SitemapProvider, policy = dynamic, cardinality = 0..n, target = null, bind = addSitemapProvider, unbind = removeSitemapProvider]
2016-01-16 14:53:22.746 [DEBUG] [.c.thing.internal.ThingManager:561 ] - Thing handler factory 'HueThingHandlerFactory' added
2016-01-16 14:53:22.747 [DEBUG] [.c.thing.internal.ThingManager:561 ] - Thing handler factory 'NtpHandlerFactory' added
2016-01-16 14:53:22.750 [DEBUG] [.c.thing.internal.ThingManager:375 ] - Thing 'samsungtv:tv:0d1cef00_00dc_1000_98a1_1c5a3ea52262' is tracked by ThingManager.
2016-01-16 14:53:22.750 [DEBUG] [.c.thing.internal.ThingManager:472 ] - Not registering a handler at this point since no handler factory for thing 'samsungtv:tv:0d1cef00_00dc_1000_98a1_1c5a3ea52262' found.
2016-01-16 14:53:22.784 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.core.items.ManagedItemProvider' has been added.
2016-01-16 14:53:22.786 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'samsungtv_tv_0d1cef00_00dc_1000_98a1_1c5a3ea52262' has been added.
2016-01-16 14:53:22.840 [INFO ] [org.eclipse.jetty.util.log :186 ] - Logging initialized @5128ms
2016-01-16 14:53:22.848 [INFO ] [.DefaultJettyAtJettyHomeHelper:159 ] - Configuring the default jetty server with [file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty.xml, file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty-selector.xml, file:/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/./etc/jetty-deployer.xml]
2016-01-16 14:53:22.848 [INFO ] [.DefaultJettyAtJettyHomeHelper:160 ] - JETTY.HOME=/Users/Pali/Projects/openhab2-addons/git/openhab-distro/launch/home/.
2016-01-16 14:53:23.028 [INFO ] [rg.eclipse.jetty.server.Server:327 ] - jetty-9.2.12.v20150709
2016-01-16 14:53:23.046 [WARN ] [.j.s.handler.RequestLogHandler:137 ] - !RequestLog
2016-01-16 14:53:23.321 [INFO ] [e.jetty.server.ServerConnector:266 ] - Started 0.0.0.0:8443@6a5b9fca{SSL-http/1.1}{0.0.0.0:8443}
2016-01-16 14:53:23.327 [INFO ] [e.jetty.server.ServerConnector:266 ] - Started ServerConnector@2c8290ed{HTTP/1.1}{0.0.0.0:8080}
2016-01-16 14:53:23.328 [INFO ] [rg.eclipse.jetty.server.Server:379 ] - Started @5616ms
2016-01-16 14:53:23.330 [INFO ] [.DefaultJettyAtJettyHomeHelper:180 ] - Default jetty server configured
2016-01-16 14:53:23.457 [INFO ] [s.ui.paper.internal.PaperUIApp:31 ] - Started Paper UI at /ui
2016-01-16 14:53:23.467 [INFO ] [.u.d.internal.DashboardService:55 ] - Started dashboard at /start
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:23.508
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.ui.chart.defaultprovider. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
2016-01-16 14:53:23.517 [DEBUG] [u.i.chart.DefaultChartProvider:97 ] - Starting up default chart provider.
2016-01-16 14:53:23.518 [DEBUG] [ui.internal.chart.ChartServlet:119 ] - Starting up chart servlet at /chart
2016-01-16 14:53:23.523 [DEBUG] [s.ui.icon.internal.IconServlet:76 ] - Starting up icon servlet at /icon
2016-01-16 14:53:23.525 [DEBUG] [o.e.s.u.c.i.servlet.CmdServlet:56 ] - Starting up CMD servlet at /classicui/CMD
2016-01-16 14:53:23.526 [INFO ] [.server.handler.ContextHandler:744 ] - Started o.e.j.s.ServletContextHandler@3836d5ba{/,null,AVAILABLE}
!ENTRY org.eclipse.equinox.ds 1 0 2016-01-16 14:53:23.584
!MESSAGE Could not bind a reference of component org.eclipse.smarthome.model.persistence.extensions. The reference is: Reference[name = PersistenceService, interface = org.eclipse.smarthome.core.persistence.PersistenceService, policy = dynamic, cardinality = 0..n, target = null, bind = addPersistenceService, unbind = removePersistenceService]
2016-01-16 14:53:23.626 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'services.cfg'
2016-01-16 14:53:23.714 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'basicui.cfg'
2016-01-16 14:53:23.717 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'classicui.cfg'
2016-01-16 14:53:23.721 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'logging.cfg'
2016-01-16 14:53:23.730 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'runtime.cfg'
2016-01-16 14:53:24.004 [DEBUG] [s.c.d.AbstractDiscoveryService:349 ] - Background discovery for discovery service 'org.eclipse.smarthome.config.discovery.internal.UpnpDiscoveryService' enabled.
2016-01-16 14:53:24.101 [DEBUG] [e.s.i.t.upnp.UpnpIOServiceImpl:156 ] - Starting UPnP IO service...
2016-01-16 14:53:24.188 [DEBUG] [.i.t.m.internal.MDNSClientImpl:37 ] - mDNS service has been started
2016-01-16 14:53:24.272 [DEBUG] [s.c.d.internal.PersistentInbox:179 ] - Updated discovery result for 'hue:bridge:0017882177dc'.
2016-01-16 14:53:24.273 [INFO ] [rthome.event.InboxUpdatedEvent:43 ] - Discovery Result with UID 'hue:bridge:0017882177dc' has been updated.
2016-01-16 14:53:24.280 [DEBUG] [.core.common.ThreadPoolManager:104 ] - Updated scheduled thread pool 'discovery' to size 3
2016-01-16 14:53:24.280 [DEBUG] [.core.common.ThreadPoolManager:109 ] - Updated thread pool 'safeCall' to size 3-10
2016-01-16 14:53:24.404 [DEBUG] [.c.thing.internal.ThingManager:561 ] - Thing handler factory 'YahooWeatherHandlerFactory' added
2016-01-16 14:53:24.407 [DEBUG] [s.c.d.AbstractDiscoveryService:349 ] - Background discovery for discovery service 'org.eclipse.smarthome.binding.yahooweather.discovery.YahooWeatherDiscoveryService' enabled.
2016-01-16 14:53:24.420 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.eclipse.smarthome.binding.yahooweather'...
2016-01-16 14:53:24.423 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.yahooweather'.
2016-01-16 14:53:24.508 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC013.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.544 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.hue'.
2016-01-16 14:53:24.545 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LCT001.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.550 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC010.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.552 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC006.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.554 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC001.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.557 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/ZLL_Light.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.559 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC007.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.561 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LWB006.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.563 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/Surface_Light_TW.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.571 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC020.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.573 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LWB004.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.575 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LCT007.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.578 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LST002.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.580 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LCT003.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.584 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LCT002.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.593 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LWB007.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.596 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LST001.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.598 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC011.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.600 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/bridge.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.602 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LLC012.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.628 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/LWL001.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.630 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/Classic_A60_RGBW.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.632 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/PAR16_50_TW.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.637 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/channels.xml' in module 'org.eclipse.smarthome.binding.hue'...
2016-01-16 14:53:24.643 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/thing-types.xml' in module 'org.eclipse.smarthome.binding.ntp'...
2016-01-16 14:53:24.646 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.ntp'.
2016-01-16 14:53:24.649 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/thing-types.xml' in module 'org.eclipse.smarthome.binding.yahooweather'...
2016-01-16 14:53:24.654 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.binding.yahooweather'.
2016-01-16 14:53:24.698 [DEBUG] [io.rest.internal.RESTActivator:32 ] - REST API has been started.
2016-01-16 14:53:24.739 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443
2016-01-16 14:53:24.740 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server._tcp.local. at port 8080
2016-01-16 14:53:24.836 [DEBUG] [o.e.s.u.b.i.servlet.CmdServlet:56 ] - Starting up CMD servlet at /basicui/CMD
2016-01-16 14:53:24.854 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/config/config.xml' in module 'org.eclipse.smarthome.ui.basic'...
2016-01-16 14:53:24.856 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.eclipse.smarthome.ui.basic'.
2016-01-16 14:53:24.936 [DEBUG] [e.s.m.t.i.GenericThingProvider:709 ] - ThingHandlerFactory added org.eclipse.smarthome.binding.hue.internal.HueThingHandlerFactory@42998737
2016-01-16 14:53:24.940 [DEBUG] [e.s.m.t.i.GenericThingProvider:709 ] - ThingHandlerFactory added org.eclipse.smarthome.binding.ntp.internal.NtpHandlerFactory@7f4c6d2f
2016-01-16 14:53:24.941 [DEBUG] [e.s.m.t.i.GenericThingProvider:709 ] - ThingHandlerFactory added org.eclipse.smarthome.binding.yahooweather.internal.YahooWeatherHandlerFactory@72d929ed
2016-01-16 14:53:24.950 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericThingProvider' has been added.
2016-01-16 14:53:24.954 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericItemChannelLinkProvider' has been added.
2016-01-16 14:53:24.960 [DEBUG] [.c.c.registry.AbstractRegistry:192 ] - Provider 'org.eclipse.smarthome.model.item.internal.GenericItemProvider' has been added.
2016-01-16 14:53:25.050 [INFO ] [.s.u.c.i.servlet.WebAppServlet:84 ] - Started Classic UI at /classicui/app
2016-01-16 14:53:25.057 [INFO ] [.s.u.b.i.servlet.WebAppServlet:84 ] - Started Basic UI at /basicui/app
2016-01-16 14:53:25.074 [INFO ] [rg.quartz.core.QuartzScheduler:2311 ] - JobFactory set to: org.eclipse.smarthome.model.rule.runtime.internal.engine.GuiceAwareJobFactory@179cf89
2016-01-16 14:53:25.075 [DEBUG] [.m.r.r.i.engine.RuleEngineImpl:94 ] - Started rule engine
2016-01-16 14:53:25.086 [DEBUG] [ui.internal.proxy.ProxyServlet:94 ] - Starting up proxy servlet at /proxy
2016-01-16 14:53:25.168 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'demo.sitemap'
2016-01-16 14:53:25.221 [INFO ] [.o.core.internal.CoreActivator:41 ] - openHAB runtime has been started (v2.0.0, build a3).
2016-01-16 14:53:25.221 [DEBUG] [.o.core.internal.CoreActivator:47 ] - Startup took 7510 ms
2016-01-16 14:53:25.312 [DEBUG] [d.YahooWeatherDiscoveryService:133 ] - Location from IP: ', Finland' coordinates: '60.1708, 24.9375'
2016-01-16 14:53:25.399 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'tv.sitemap'
2016-01-16 14:53:25.425 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'demo.things'
2016-01-16 14:53:25.528 [DEBUG] [e.s.m.t.i.GenericThingProvider:202 ] - Read things from model 'demo.things'
2016-01-16 14:53:25.573 [DEBUG] [.c.thing.internal.ThingManager:375 ] - Thing 'yahooweather:weather:berlin' is tracked by ThingManager.
2016-01-16 14:53:25.573 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'yahooweather:weather:berlin' has been added.
2016-01-16 14:53:25.573 [DEBUG] [.c.thing.internal.ThingManager:499 ] - Calling registerHandler handler for thing 'yahooweather:weather:berlin' at 'org.eclipse.smarthome.binding.yahooweather.internal.YahooWeatherHandlerFactory@72d929ed'.
2016-01-16 14:53:25.574 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - 'yahooweather:weather:berlin' updated: INITIALIZING
2016-01-16 14:53:25.575 [INFO ] [nt.ThingStatusInfoChangedEvent:43 ] - 'yahooweather:weather:berlin' changed from UNINITIALIZED to INITIALIZING
2016-01-16 14:53:25.576 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'thingHandler' of size 3
2016-01-16 14:53:25.579 [DEBUG] [.e.s.b.y.h.YahooWeatherHandler:60 ] - Initializing YahooWeather handler.
2016-01-16 14:53:25.581 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - 'yahooweather:weather:berlin' updated: ONLINE
2016-01-16 14:53:25.585 [INFO ] [nt.ThingStatusInfoChangedEvent:43 ] - 'yahooweather:weather:berlin' changed from INITIALIZING to ONLINE
2016-01-16 14:53:25.586 [DEBUG] [.c.thing.internal.ThingManager:85 ] - Thing handler for thing 'yahooweather:weather:berlin' added.
2016-01-16 14:53:25.586 [DEBUG] [.c.thing.internal.ThingManager:264 ] - Assigning handler for thing 'yahooweather:weather:berlin'.
2016-01-16 14:53:26.072 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - 'yahooweather:weather:berlin' updated: ONLINE
2016-01-16 14:53:26.078 [DEBUG] [.c.thing.internal.ThingManager:375 ] - Thing 'ntp:ntp:demo' is tracked by ThingManager.
2016-01-16 14:53:26.078 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'ntp:ntp:demo' has been added.
2016-01-16 14:53:26.078 [DEBUG] [.c.thing.internal.ThingManager:499 ] - Calling registerHandler handler for thing 'ntp:ntp:demo' at 'org.eclipse.smarthome.binding.ntp.internal.NtpHandlerFactory@7f4c6d2f'.
2016-01-16 14:53:26.079 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - 'ntp:ntp:demo' updated: INITIALIZING
2016-01-16 14:53:26.079 [INFO ] [nt.ThingStatusInfoChangedEvent:43 ] - 'ntp:ntp:demo' changed from UNINITIALIZED to INITIALIZING
2016-01-16 14:53:26.081 [DEBUG] [binding.ntp.handler.NtpHandler:95 ] - Initializing NTP handler for 'ntp:ntp:demo'.
2016-01-16 14:53:26.084 [DEBUG] [binding.ntp.handler.NtpHandler:107 ] - using default TZ: sun.util.calendar.ZoneInfo[id="Europe/Helsinki",offset=7200000,dstSavings=3600000,useDaylight=true,transitions=118,lastRule=java.util.SimpleTimeZone[id=Europe/Helsinki,offset=7200000,dstSavings=3600000,useDaylight=true,startYear=0,startMode=2,startMonth=2,startDay=-1,startDayOfWeek=1,startTime=3600000,startTimeMode=2,endMode=2,endMonth=9,endDay=-1,endDayOfWeek=1,endTime=3600000,endTimeMode=2]]
2016-01-16 14:53:26.084 [DEBUG] [binding.ntp.handler.NtpHandler:115 ] - using default locale: en_US
2016-01-16 14:53:26.087 [DEBUG] [.c.thing.internal.ThingManager:85 ] - Thing handler for thing 'ntp:ntp:demo' added.
2016-01-16 14:53:26.088 [DEBUG] [.c.thing.internal.ThingManager:264 ] - Assigning handler for thing 'ntp:ntp:demo'.
2016-01-16 14:53:26.115 [DEBUG] [d.YahooWeatherDiscoveryService:139 ] - Location from locationID: '26194557' is: 'Helsinki, Finland'
2016-01-16 14:53:26.131 [DEBUG] [s.c.d.internal.PersistentInbox:179 ] - Updated discovery result for 'yahooweather:weather:26194557'.
2016-01-16 14:53:26.132 [INFO ] [rthome.event.InboxUpdatedEvent:43 ] - Discovery Result with UID 'yahooweather:weather:26194557' has been updated.
2016-01-16 14:53:26.564 [DEBUG] [binding.ntp.handler.NtpHandler:185 ] - Got time update from: 0.pool.ntp.org
2016-01-16 14:53:26.565 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - 'ntp:ntp:demo' updated: ONLINE
2016-01-16 14:53:26.565 [DEBUG] [binding.ntp.handler.NtpHandler:155 ] - delta system time: -2
2016-01-16 14:53:26.566 [INFO ] [nt.ThingStatusInfoChangedEvent:43 ] - 'ntp:ntp:demo' changed from INITIALIZING to ONLINE
2016-01-16 14:53:26.576 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'logging.persist'
2016-01-16 14:53:26.592 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'rrd4j.persist'
2016-01-16 14:53:26.598 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'demo.rules'
2016-01-16 14:53:26.925 [DEBUG] [s.m.r.r.i.e.RuleTriggerManager:491 ] - Scheduled rule Set random room temperatures with cron expression 0 0/5 * * * ?
2016-01-16 14:53:26.927 [DEBUG] [s.m.r.r.i.e.RuleTriggerManager:491 ] - Scheduled rule Update max and min temperatures with cron expression 0 0 0 * * ?
2016-01-16 14:53:26.929 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'demo.script'
2016-01-16 14:53:27.024 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'demo.items'
2016-01-16 14:53:27.053 [DEBUG] [.e.s.m.i.i.GenericItemProvider:151 ] - Processing binding configs for items from model 'demo.items'
2016-01-16 14:53:27.067 [DEBUG] [.e.s.m.i.i.GenericItemProvider:130 ] - Read items from model 'demo.items'
2016-01-16 14:53:27.069 [INFO ] [vent.ItemChannelLinkAddedEvent:43 ] - Link 'Weather_Temperature-yahooweather:weather:berlin:temperature' has been added.
2016-01-16 14:53:27.074 [INFO ] [vent.ItemChannelLinkAddedEvent:43 ] - Link 'Sun_Elevation-astro:sun:home:position#elevation' has been added.
2016-01-16 14:53:27.076 [INFO ] [vent.ItemChannelLinkAddedEvent:43 ] - Link 'CurrentDate-ntp:ntp:demo:dateTime' has been added.
2016-01-16 14:53:27.089 [INFO ] [.e.s.m.c.i.ModelRepositoryImpl:86 ] - Loading model 'tv.items'
2016-01-16 14:53:27.091 [DEBUG] [.e.s.m.i.i.GenericItemProvider:151 ] - Processing binding configs for items from model 'tv.items'
2016-01-16 14:53:27.093 [DEBUG] [.e.s.m.i.i.GenericItemProvider:130 ] - Read items from model 'demo.items'
2016-01-16 14:53:27.095 [DEBUG] [.e.s.m.i.i.GenericItemProvider:130 ] - Read items from model 'tv.items'
2016-01-16 14:53:30.132 [DEBUG] [.m.r.r.i.engine.RuleEngineImpl:273 ] - Executing startup rule 'Initialize light states'