2021-07-21 19:12:06.183 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 80: Handler disposed. Unregistering listener. 2021-07-21 19:12:06.202 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 77: Handler disposed. Unregistering listener. 2021-07-21 19:12:06.240 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing receive thread 2021-07-21 19:12:06.241 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Receive thread dispose 2021-07-21 19:12:06.242 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Disposing serial connection 2021-07-21 19:12:06.243 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Serial connection disposed 2021-07-21 19:12:06.244 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Stopped ZWave serial handler 2021-07-21 19:12:06.248 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Deactivate zwave:serial_zstick:2f4ef5d0 2021-07-21 19:12:06.257 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Querying state active 2021-07-21 19:12:06.259 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : getting deactivate: deactivate 2021-07-21 19:12:06.260 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Locating method deactivate in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.261 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.deactivate([interface org.osgi.service.component.ComponentContext]) not found 2021-07-21 19:12:06.262 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Locating method deactivate in class org.openhab.core.thing.binding.BaseThingHandlerFactory 2021-07-21 19:12:06.263 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Found deactivate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.deactivate(org.osgi.service.component.ComponentContext) 2021-07-21 19:12:06.265 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : invoking deactivate: deactivate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-07-21 19:12:06.266 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : invoked deactivate: deactivate 2021-07-21 19:12:06.268 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : DependencyManager: SerialPortManager close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@1599b7d2 at tracking count 1 refpairs: [[RefPair: ref: [{org.openhab.core.io.transport.serial.SerialPortManager}={service.id=491, service.bundleid=312, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=306}] service: [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl@2cafefa]]] 2021-07-21 19:12:06.269 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : getting unbind: unsetSerialPortManager 2021-07-21 19:12:06.270 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Locating method unsetSerialPortManager in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.271 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.unsetSerialPortManager 2021-07-21 19:12:06.272 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.unsetSerialPortManager([interface org.osgi.framework.ServiceReference]) not found 2021-07-21 19:12:06.273 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.unsetSerialPortManager([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-07-21 19:12:06.274 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : getReferenceClass: Looking for interface class org.openhab.core.io.transport.serial.SerialPortManager through loader of org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.276 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : getParameterClass: Found class org.openhab.core.io.transport.serial.SerialPortManager 2021-07-21 19:12:06.277 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.io.transport.serial.SerialPortManager 2021-07-21 19:12:06.278 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.unsetSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager) 2021-07-21 19:12:06.278 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Found unbind method: protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.unsetSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager) 2021-07-21 19:12:06.279 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : invoking unbind: unsetSerialPortManager: parameters [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl] 2021-07-21 19:12:06.280 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : invoked unbind: unsetSerialPortManager 2021-07-21 19:12:06.281 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified 2021-07-21 19:12:06.282 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Changed state from active to satisfied 2021-07-21 19:12:06.285 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Deactivating dependency managers 2021-07-21 19:12:06.286 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Disabling dependency managers 2021-07-21 19:12:06.288 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : unregistering service listener for dependency SerialPortManager 2021-07-21 19:12:06.289 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Querying state satisfied 2021-07-21 19:12:06.290 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Changed state from satisfied to disposed 2021-07-21 19:12:06.291 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(390)] : Disposing component (reason: 6) 2021-07-21 19:12:06.609 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : BundleComponentActivator : ComponentHolder created. 2021-07-21 19:12:06.611 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : BundleComponentActivator : ComponentHolder created. 2021-07-21 19:12:06.619 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ConfigDescriptionRegistryinterface=org.openhab.core.config.core.ConfigDescriptionRegistry, filter=null, policy=static, cardinality=1..1, bind=setConfigDescriptionRegistry, unbind=unsetConfigDescriptionRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-07-21 19:12:06.621 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingRegistryinterface=org.openhab.core.thing.ThingRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingRegistry, unbind=unsetThingRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-07-21 19:12:06.622 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Dependency Manager created ThingTypeRegistryinterface=org.openhab.core.thing.type.ThingTypeRegistry, filter=null, policy=static, cardinality=1..1, bind=setThingTypeRegistry, unbind=unsetThingTypeRegistry, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-07-21 19:12:06.623 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveConfigProvider, immediate=true, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveConfigProvider] 2021-07-21 19:12:06.624 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Services: scope=singleton, services=[org.openhab.core.config.core.ConfigDescriptionProvider, org.openhab.core.config.core.ConfigOptionProvider] 2021-07-21 19:12:06.625 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component Properties: {} 2021-07-21 19:12:06.626 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled 2021-07-21 19:12:06.627 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled 2021-07-21 19:12:06.628 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Component can not be activated since it is in state disabled 2021-07-21 19:12:06.628 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider] : Querying state disabled 2021-07-21 19:12:06.630 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Updating target filters 2021-07-21 19:12:06.631 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No change in target property for dependency ConfigDescriptionRegistry: currently registered: false 2021-07-21 19:12:06.632 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No existing service listener to unregister for dependency ConfigDescriptionRegistry 2021-07-21 19:12:06.633 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Setting target property for dependency ConfigDescriptionRegistry to null 2021-07-21 19:12:06.634 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : New service tracker for ConfigDescriptionRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry), initialReferenceFilter (objectClass=org.openhab.core.config.core.ConfigDescriptionRegistry) 2021-07-21 19:12:06.635 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ConfigDescriptionRegistry tracker reset (closed) 2021-07-21 19:12:06.655 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=199, service.bundleid=164, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107} (enter) 2021-07-21 19:12:06.657 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic active: false trackerOpened: false optional: false 2021-07-21 19:12:06.658 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ConfigDescriptionRegistry tracking 1 SingleStatic added {org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=199, service.bundleid=164, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107} (exit) 2021-07-21 19:12:06.659 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ConfigDescriptionRegistry tracker opened 2021-07-21 19:12:06.660 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : registering service listener for dependency ConfigDescriptionRegistry 2021-07-21 19:12:06.661 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No change in target property for dependency ThingRegistry: currently registered: false 2021-07-21 19:12:06.662 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No existing service listener to unregister for dependency ThingRegistry 2021-07-21 19:12:06.663 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Setting target property for dependency ThingRegistry to null 2021-07-21 19:12:06.664 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : New service tracker for ThingRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.ThingRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.ThingRegistry) 2021-07-21 19:12:06.665 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingRegistry tracker reset (closed) 2021-07-21 19:12:06.667 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=301, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=34} (enter) 2021-07-21 19:12:06.668 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingRegistry tracking 2 SingleStatic active: false trackerOpened: false optional: false 2021-07-21 19:12:06.669 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingRegistry tracking 2 SingleStatic added {org.openhab.core.thing.ThingRegistry}={service.id=301, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=34} (exit) 2021-07-21 19:12:06.670 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingRegistry tracker opened 2021-07-21 19:12:06.671 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : registering service listener for dependency ThingRegistry 2021-07-21 19:12:06.672 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No change in target property for dependency ThingTypeRegistry: currently registered: false 2021-07-21 19:12:06.673 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : No existing service listener to unregister for dependency ThingTypeRegistry 2021-07-21 19:12:06.673 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Setting target property for dependency ThingTypeRegistry to null 2021-07-21 19:12:06.674 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : New service tracker for ThingTypeRegistry, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.type.ThingTypeRegistry), initialReferenceFilter (objectClass=org.openhab.core.thing.type.ThingTypeRegistry) 2021-07-21 19:12:06.675 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingTypeRegistry tracker reset (closed) 2021-07-21 19:12:06.677 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=166, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=49} (enter) 2021-07-21 19:12:06.678 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingTypeRegistry tracking 3 SingleStatic active: false trackerOpened: false optional: false 2021-07-21 19:12:06.679 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingTypeRegistry tracking 3 SingleStatic added {org.openhab.core.thing.type.ThingTypeRegistry}={service.id=166, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=49} (exit) 2021-07-21 19:12:06.679 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : dm ThingTypeRegistry tracker opened 2021-07-21 19:12:06.680 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : registering service listener for dependency ThingTypeRegistry 2021-07-21 19:12:06.681 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Changed state from disabled to unsatisfiedReference 2021-07-21 19:12:06.682 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Component enabled 2021-07-21 19:12:06.683 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : ActivateInternal 2021-07-21 19:12:06.684 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.685 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.686 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Activating component from state unsatisfiedReference 2021-07-21 19:12:06.686 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.687 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.688 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Changed state from unsatisfiedReference to satisfied 2021-07-21 19:12:06.689 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : registration change queue [registered] 2021-07-21 19:12:06.693 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveConfigProvider() 2021-07-21 19:12:06.694 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveConfigProvider() 2021-07-21 19:12:06.695 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getting bind: setConfigDescriptionRegistry 2021-07-21 19:12:06.696 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Locating method setConfigDescriptionRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.696 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry 2021-07-21 19:12:06.697 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.framework.ServiceReference]) not found 2021-07-21 19:12:06.698 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-07-21 19:12:06.699 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getReferenceClass: Looking for interface class org.openhab.core.config.core.ConfigDescriptionRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.699 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getParameterClass: Found class org.openhab.core.config.core.ConfigDescriptionRegistry 2021-07-21 19:12:06.700 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.config.core.ConfigDescriptionRegistry 2021-07-21 19:12:06.701 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry) 2021-07-21 19:12:06.702 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setConfigDescriptionRegistry(org.openhab.core.config.core.ConfigDescriptionRegistry) 2021-07-21 19:12:06.702 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getting bind: setThingRegistry 2021-07-21 19:12:06.703 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Locating method setThingRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.704 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry 2021-07-21 19:12:06.704 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.framework.ServiceReference]) not found 2021-07-21 19:12:06.705 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-07-21 19:12:06.706 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getReferenceClass: Looking for interface class org.openhab.core.thing.ThingRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.707 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getParameterClass: Found class org.openhab.core.thing.ThingRegistry 2021-07-21 19:12:06.708 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.ThingRegistry 2021-07-21 19:12:06.709 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry) 2021-07-21 19:12:06.710 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingRegistry(org.openhab.core.thing.ThingRegistry) 2021-07-21 19:12:06.711 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getting bind: setThingTypeRegistry 2021-07-21 19:12:06.711 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Locating method setThingTypeRegistry in class org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.712 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry 2021-07-21 19:12:06.713 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.framework.ServiceReference]) not found 2021-07-21 19:12:06.714 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-07-21 19:12:06.715 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getReferenceClass: Looking for interface class org.openhab.core.thing.type.ThingTypeRegistry through loader of org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.715 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getParameterClass: Found class org.openhab.core.thing.type.ThingTypeRegistry 2021-07-21 19:12:06.716 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.type.ThingTypeRegistry 2021-07-21 19:12:06.717 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry) 2021-07-21 19:12:06.718 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveConfigProvider.setThingTypeRegistry(org.openhab.core.thing.type.ThingTypeRegistry) 2021-07-21 19:12:06.719 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : This thread collected dependencies 2021-07-21 19:12:06.719 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getService (single component manager) dependencies collected. 2021-07-21 19:12:06.720 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state satisfied 2021-07-21 19:12:06.721 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Querying state satisfied 2021-07-21 19:12:06.722 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : For dependency ConfigDescriptionRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.config.core.ConfigDescriptionRegistry}={service.id=199, service.bundleid=164, service.scope=bundle, component.name=org.openhab.core.config.core.ConfigDescriptionRegistry, component.id=107}] service: [org.openhab.core.config.core.ConfigDescriptionRegistry@32b44a69]]] 2021-07-21 19:12:06.723 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : For dependency ThingRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.ThingRegistry}={service.id=301, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.internal.ThingRegistryImpl, component.id=34}] service: [org.openhab.core.thing.internal.ThingRegistryImpl@35eef55e]]] 2021-07-21 19:12:06.724 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : For dependency ThingTypeRegistry, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.type.ThingTypeRegistry}={service.id=166, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.type.ThingTypeRegistry, component.id=49}] service: [org.openhab.core.thing.type.ThingTypeRegistry@7c385d8e]]] 2021-07-21 19:12:06.727 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoking bind: setConfigDescriptionRegistry: parameters [org.openhab.core.config.core.ConfigDescriptionRegistry] 2021-07-21 19:12:06.727 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoked bind: setConfigDescriptionRegistry 2021-07-21 19:12:06.728 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoking bind: setThingRegistry: parameters [org.openhab.core.thing.internal.ThingRegistryImpl] 2021-07-21 19:12:06.729 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoked bind: setThingRegistry 2021-07-21 19:12:06.730 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoking bind: setThingTypeRegistry: parameters [org.openhab.core.thing.type.ThingTypeRegistry] 2021-07-21 19:12:06.731 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : invoked bind: setThingTypeRegistry 2021-07-21 19:12:06.732 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : getting activate: activate 2021-07-21 19:12:06.733 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveConfigProvider 2021-07-21 19:12:06.734 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method org.openhab.binding.zwave.internal.ZWaveConfigProvider.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-07-21 19:12:06.735 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Locating method activate in class java.lang.Object 2021-07-21 19:12:06.735 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Declared Method java.lang.Object.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-07-21 19:12:06.736 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : activate method [activate] not found, ignoring 2021-07-21 19:12:06.737 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Set implementation object for component 2021-07-21 19:12:06.738 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveConfigProvider(391)] : Changed state from satisfied to active 2021-07-21 19:12:06.740 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Dependency Manager created SerialPortManagerinterface=org.openhab.core.io.transport.serial.SerialPortManager, filter=null, policy=static, cardinality=1..1, bind=setSerialPortManager, unbind=unsetSerialPortManager, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-07-21 19:12:06.742 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component created: DS=DS13, implementation=org.openhab.binding.zwave.internal.ZWaveHandlerFactory, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] 2021-07-21 19:12:06.743 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Services: scope=singleton, services=[org.openhab.core.thing.binding.ThingHandlerFactory] 2021-07-21 19:12:06.744 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component Properties: {} 2021-07-21 19:12:06.745 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled 2021-07-21 19:12:06.746 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled 2021-07-21 19:12:06.747 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Component can not be activated since it is in state disabled 2021-07-21 19:12:06.748 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory] : Querying state disabled 2021-07-21 19:12:06.749 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Updating target filters 2021-07-21 19:12:06.750 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : No change in target property for dependency SerialPortManager: currently registered: false 2021-07-21 19:12:06.750 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : No existing service listener to unregister for dependency SerialPortManager 2021-07-21 19:12:06.751 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Setting target property for dependency SerialPortManager to null 2021-07-21 19:12:06.752 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : New service tracker for SerialPortManager, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.io.transport.serial.SerialPortManager), initialReferenceFilter (objectClass=org.openhab.core.io.transport.serial.SerialPortManager) 2021-07-21 19:12:06.753 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : dm SerialPortManager tracker reset (closed) 2021-07-21 19:12:06.756 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : dm SerialPortManager tracking 1 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=491, service.bundleid=312, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=306} (enter) 2021-07-21 19:12:06.757 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : dm SerialPortManager tracking 1 SingleStatic active: false trackerOpened: false optional: false 2021-07-21 19:12:06.758 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : dm SerialPortManager tracking 1 SingleStatic added {org.openhab.core.io.transport.serial.SerialPortManager}={service.id=491, service.bundleid=312, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=306} (exit) 2021-07-21 19:12:06.759 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : dm SerialPortManager tracker opened 2021-07-21 19:12:06.759 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : registering service listener for dependency SerialPortManager 2021-07-21 19:12:06.760 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Changed state from disabled to unsatisfiedReference 2021-07-21 19:12:06.761 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Component enabled 2021-07-21 19:12:06.762 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : ActivateInternal 2021-07-21 19:12:06.762 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.763 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.764 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Activating component from state unsatisfiedReference 2021-07-21 19:12:06.765 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.765 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state unsatisfiedReference 2021-07-21 19:12:06.766 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Changed state from unsatisfiedReference to satisfied 2021-07-21 19:12:06.767 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : registration change queue [registered] 2021-07-21 19:12:06.771 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Checking constructor public org.openhab.binding.zwave.internal.ZWaveHandlerFactory() 2021-07-21 19:12:06.771 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Found constructor with 0 arguments : public org.openhab.binding.zwave.internal.ZWaveHandlerFactory() 2021-07-21 19:12:06.772 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : getting bind: setSerialPortManager 2021-07-21 19:12:06.773 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Locating method setSerialPortManager in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.774 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : doFindMethod: Looking for method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager 2021-07-21 19:12:06.775 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.framework.ServiceReference]) not found 2021-07-21 19:12:06.776 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-07-21 19:12:06.776 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : getReferenceClass: Looking for interface class org.openhab.core.io.transport.serial.SerialPortManager through loader of org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.777 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : getParameterClass: Found class org.openhab.core.io.transport.serial.SerialPortManager 2021-07-21 19:12:06.778 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.io.transport.serial.SerialPortManager 2021-07-21 19:12:06.779 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : doFindMethod: Found Method protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager) 2021-07-21 19:12:06.779 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Found bind method: protected void org.openhab.binding.zwave.internal.ZWaveHandlerFactory.setSerialPortManager(org.openhab.core.io.transport.serial.SerialPortManager) 2021-07-21 19:12:06.780 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : This thread collected dependencies 2021-07-21 19:12:06.781 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : getService (single component manager) dependencies collected. 2021-07-21 19:12:06.782 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state satisfied 2021-07-21 19:12:06.784 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Querying state satisfied 2021-07-21 19:12:06.785 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : For dependency SerialPortManager, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.io.transport.serial.SerialPortManager}={service.id=491, service.bundleid=312, service.scope=bundle, component.name=org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl, component.id=306}] service: [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl@2cafefa]]] 2021-07-21 19:12:06.786 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : invoking bind: setSerialPortManager: parameters [org.openhab.core.io.transport.serial.internal.SerialPortManagerImpl] 2021-07-21 19:12:06.787 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : invoked bind: setSerialPortManager 2021-07-21 19:12:06.787 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : getting activate: activate 2021-07-21 19:12:06.789 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Locating method activate in class org.openhab.binding.zwave.internal.ZWaveHandlerFactory 2021-07-21 19:12:06.790 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Declared Method org.openhab.binding.zwave.internal.ZWaveHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-07-21 19:12:06.791 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Locating method activate in class org.openhab.core.thing.binding.BaseThingHandlerFactory 2021-07-21 19:12:06.792 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Found activate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.activate(org.osgi.service.component.ComponentContext) 2021-07-21 19:12:06.793 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-07-21 19:12:06.795 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : invoked activate: activate 2021-07-21 19:12:06.796 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Set implementation object for component 2021-07-21 19:12:06.797 [DEBUG] [g.zwave.internal.ZWaveHandlerFactory] - bundle org.openhab.binding.zwave:3.1.0 (306)[org.openhab.binding.zwave.internal.ZWaveHandlerFactory(392)] : Changed state from satisfied to active 2021-07-21 19:12:12.392 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - Creating ZWave discovery service for zwave:serial_zstick:30038385 with scan time of 60 2021-07-21 19:12:12.394 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Active zwave:serial_zstick:30038385 2021-07-21 19:12:12.395 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null 2021-07-21 19:12:12.490 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Initializing ZWave serial controller. 2021-07-21 19:12:12.495 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Initializing ZWave Controller zwave:serial_zstick:30038385. 2021-07-21 19:12:12.556 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:30038385:node89. 2021-07-21 19:12:12.622 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:30038385:node113. 2021-07-21 19:12:12.626 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:30038385:node75. 2021-07-21 19:12:12.628 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:30038385:node86. 2021-07-21 19:12:12.635 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:30038385:node22.