2021-12-03 15:40:04.265 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : BundleComponentActivator : ComponentHolder created. 2021-12-03 15:40:04.267 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : BundleComponentActivator : ComponentHolder created. 2021-12-03 15:40:04.270 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : BundleComponentActivator : ComponentHolder created. 2021-12-03 15:40:04.276 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Dependency Manager created $000interface=org.openhab.core.io.transport.upnp.UpnpIOService, filter=null, policy=static, cardinality=1..1, bind=null, unbind=null, updated=null, field=null, field-option=null, collection-type=null, parameter=0 2021-12-03 15:40:04.277 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Dependency Manager created WemoHttpCallFactoryinterface=org.openhab.binding.wemo.internal.WemoHttpCallFactory, filter=null, policy=dynamic, cardinality=0..1, bind=setWemoHttpCallFactory, unbind=unsetWemoHttpCallFactory, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-12-03 15:40:04.277 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Component created: DS=DS14, implementation=org.openhab.binding.wemo.internal.WemoHandlerFactory, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[binding.wemo] 2021-12-03 15:40:04.278 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Component Services: scope=singleton, services=[org.openhab.core.thing.binding.ThingHandlerFactory] 2021-12-03 15:40:04.279 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Component Properties: {} 2021-12-03 15:40:04.280 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Querying state disabled 2021-12-03 15:40:04.280 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Querying state disabled 2021-12-03 15:40:04.281 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Component can not be activated since it is in state disabled 2021-12-03 15:40:04.282 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory] : Querying state disabled 2021-12-03 15:40:04.283 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Updating target filters 2021-12-03 15:40:04.284 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : No change in target property for dependency $000: currently registered: false 2021-12-03 15:40:04.285 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : No existing service listener to unregister for dependency $000 2021-12-03 15:40:04.285 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Setting target property for dependency $000 to null 2021-12-03 15:40:04.286 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : New service tracker for $000, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.io.transport.upnp.UpnpIOService), initialReferenceFilter (objectClass=org.openhab.core.io.transport.upnp.UpnpIOService) 2021-12-03 15:40:04.287 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm $000 tracker reset (closed) 2021-12-03 15:40:04.290 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm $000 tracking 1 SingleStatic added {org.openhab.core.io.transport.upnp.UpnpIOService, org.jupnp.registry.RegistryListener}={service.id=495, service.bundleid=289, service.scope=bundle, component.name=org.openhab.core.io.transport.upnp.internal.UpnpIOServiceImpl, component.id=318} (enter) 2021-12-03 15:40:04.291 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm $000 tracking 1 SingleStatic active: false trackerOpened: false optional: false 2021-12-03 15:40:04.291 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm $000 tracking 1 SingleStatic added {org.openhab.core.io.transport.upnp.UpnpIOService, org.jupnp.registry.RegistryListener}={service.id=495, service.bundleid=289, service.scope=bundle, component.name=org.openhab.core.io.transport.upnp.internal.UpnpIOServiceImpl, component.id=318} (exit) 2021-12-03 15:40:04.292 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm $000 tracker opened 2021-12-03 15:40:04.293 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : registering service listener for dependency $000 2021-12-03 15:40:04.294 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : No change in target property for dependency WemoHttpCallFactory: currently registered: false 2021-12-03 15:40:04.295 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : No existing service listener to unregister for dependency WemoHttpCallFactory 2021-12-03 15:40:04.295 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Setting target property for dependency WemoHttpCallFactory to null 2021-12-03 15:40:04.296 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : New service tracker for WemoHttpCallFactory, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.binding.wemo.internal.WemoHttpCallFactory), initialReferenceFilter (objectClass=org.openhab.binding.wemo.internal.WemoHttpCallFactory) 2021-12-03 15:40:04.297 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm WemoHttpCallFactory tracker reset (closed) 2021-12-03 15:40:04.303 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : dm WemoHttpCallFactory tracker opened 2021-12-03 15:40:04.304 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : registering service listener for dependency WemoHttpCallFactory 2021-12-03 15:40:04.305 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Changed state from disabled to unsatisfiedReference 2021-12-03 15:40:04.306 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Component enabled 2021-12-03 15:40:04.306 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : ActivateInternal 2021-12-03 15:40:04.307 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.308 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.309 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Activating component from state unsatisfiedReference 2021-12-03 15:40:04.310 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.310 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.311 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Changed state from unsatisfiedReference to satisfied 2021-12-03 15:40:04.312 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : registration change queue [registered] 2021-12-03 15:40:04.316 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Checking constructor public org.openhab.binding.wemo.internal.WemoHandlerFactory(org.openhab.core.io.transport.upnp.UpnpIOService) 2021-12-03 15:40:04.317 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : getReferenceClass: Looking for interface class org.openhab.core.io.transport.upnp.UpnpIOService through loader of org.openhab.binding.wemo.internal.WemoHandlerFactory 2021-12-03 15:40:04.318 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : getParameterClass: Found class org.openhab.core.io.transport.upnp.UpnpIOService 2021-12-03 15:40:04.319 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Found constructor with 1 arguments : public org.openhab.binding.wemo.internal.WemoHandlerFactory(org.openhab.core.io.transport.upnp.UpnpIOService) 2021-12-03 15:40:04.320 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : This thread collected dependencies 2021-12-03 15:40:04.320 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : getService (single component manager) dependencies collected. 2021-12-03 15:40:04.321 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state satisfied 2021-12-03 15:40:04.322 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Querying state satisfied 2021-12-03 15:40:04.323 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : For dependency $000, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.io.transport.upnp.UpnpIOService, org.jupnp.registry.RegistryListener}={service.id=495, service.bundleid=289, service.scope=bundle, component.name=org.openhab.core.io.transport.upnp.internal.UpnpIOServiceImpl, component.id=318}] service: [null]]] 2021-12-03 15:40:04.323 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : For dependency WemoHttpCallFactory, optional: true; to bind: [] 2021-12-03 15:40:04.327 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : getting activate: activate 2021-12-03 15:40:04.328 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Locating method activate in class org.openhab.binding.wemo.internal.WemoHandlerFactory 2021-12-03 15:40:04.330 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Declared Method org.openhab.binding.wemo.internal.WemoHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-12-03 15:40:04.331 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Locating method activate in class org.openhab.core.thing.binding.BaseThingHandlerFactory 2021-12-03 15:40:04.332 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Found activate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.activate(org.osgi.service.component.ComponentContext) 2021-12-03 15:40:04.333 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-12-03 15:40:04.334 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : invoked activate: activate 2021-12-03 15:40:04.335 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Set implementation object for component 2021-12-03 15:40:04.336 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.WemoHandlerFactory(973)] : Changed state from satisfied to active 2021-12-03 15:40:04.338 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Component created: DS=DS13, implementation=org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] 2021-12-03 15:40:04.339 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Component Services: scope=singleton, services=[org.openhab.core.config.discovery.upnp.UpnpDiscoveryParticipant] 2021-12-03 15:40:04.340 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Component Properties: {} 2021-12-03 15:40:04.341 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Querying state disabled 2021-12-03 15:40:04.341 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Querying state disabled 2021-12-03 15:40:04.342 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Component can not be activated since it is in state disabled 2021-12-03 15:40:04.343 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant] : Querying state disabled 2021-12-03 15:40:04.344 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Updating target filters 2021-12-03 15:40:04.345 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Changed state from disabled to unsatisfiedReference 2021-12-03 15:40:04.346 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Component enabled 2021-12-03 15:40:04.347 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : ActivateInternal 2021-12-03 15:40:04.347 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.348 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.349 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Activating component from state unsatisfiedReference 2021-12-03 15:40:04.350 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.350 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.351 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Changed state from unsatisfiedReference to satisfied 2021-12-03 15:40:04.352 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : registration change queue [registered] 2021-12-03 15:40:04.355 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Checking constructor public org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant() 2021-12-03 15:40:04.356 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Found constructor with 0 arguments : public org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant() 2021-12-03 15:40:04.357 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : This thread collected dependencies 2021-12-03 15:40:04.358 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : getService (single component manager) dependencies collected. 2021-12-03 15:40:04.358 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state satisfied 2021-12-03 15:40:04.359 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Querying state satisfied 2021-12-03 15:40:04.360 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : getting activate: activate 2021-12-03 15:40:04.360 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Locating method activate in class org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant 2021-12-03 15:40:04.361 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Declared Method org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-12-03 15:40:04.362 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Locating method activate in class java.lang.Object 2021-12-03 15:40:04.363 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Declared Method java.lang.Object.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-12-03 15:40:04.364 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : activate method [activate] not found, ignoring 2021-12-03 15:40:04.364 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Set implementation object for component 2021-12-03 15:40:04.365 [DEBUG] [l.discovery.WemoDiscoveryParticipant] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryParticipant(974)] : Changed state from satisfied to active 2021-12-03 15:40:04.367 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Dependency Manager created UpnpServiceinterface=org.jupnp.UpnpService, filter=null, policy=static, cardinality=1..1, bind=setUpnpService, unbind=unsetUpnpService, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-12-03 15:40:04.368 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Component created: DS=DS13, implementation=org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[discovery.wemo] 2021-12-03 15:40:04.368 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Component Services: scope=singleton, services=[org.openhab.core.config.discovery.DiscoveryService] 2021-12-03 15:40:04.369 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Component Properties: {} 2021-12-03 15:40:04.370 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Querying state disabled 2021-12-03 15:40:04.370 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Querying state disabled 2021-12-03 15:40:04.371 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Component can not be activated since it is in state disabled 2021-12-03 15:40:04.372 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService] : Querying state disabled 2021-12-03 15:40:04.373 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Updating target filters 2021-12-03 15:40:04.374 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : No change in target property for dependency UpnpService: currently registered: false 2021-12-03 15:40:04.374 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : No existing service listener to unregister for dependency UpnpService 2021-12-03 15:40:04.375 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Setting target property for dependency UpnpService to null 2021-12-03 15:40:04.376 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : New service tracker for UpnpService, initial active: false, previous references: {}, classFilter: (objectClass=org.jupnp.UpnpService), initialReferenceFilter (objectClass=org.jupnp.UpnpService) 2021-12-03 15:40:04.377 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : dm UpnpService tracker reset (closed) 2021-12-03 15:40:04.380 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : dm UpnpService tracking 1 SingleStatic added {org.jupnp.UpnpService}={service.id=493, service.bundleid=260, service.scope=bundle, component.name=org.jupnp.upnpservice, component.id=315} (enter) 2021-12-03 15:40:04.381 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : dm UpnpService tracking 1 SingleStatic active: false trackerOpened: false optional: false 2021-12-03 15:40:04.381 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : dm UpnpService tracking 1 SingleStatic added {org.jupnp.UpnpService}={service.id=493, service.bundleid=260, service.scope=bundle, component.name=org.jupnp.upnpservice, component.id=315} (exit) 2021-12-03 15:40:04.383 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : dm UpnpService tracker opened 2021-12-03 15:40:04.384 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : registering service listener for dependency UpnpService 2021-12-03 15:40:04.385 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Changed state from disabled to unsatisfiedReference 2021-12-03 15:40:04.386 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Component enabled 2021-12-03 15:40:04.386 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : ActivateInternal 2021-12-03 15:40:04.387 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.388 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.388 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Activating component from state unsatisfiedReference 2021-12-03 15:40:04.389 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.390 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state unsatisfiedReference 2021-12-03 15:40:04.390 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Changed state from unsatisfiedReference to satisfied 2021-12-03 15:40:04.391 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : registration change queue [registered] 2021-12-03 15:40:04.395 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Checking constructor public org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService() 2021-12-03 15:40:04.396 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Found constructor with 0 arguments : public org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService() 2021-12-03 15:40:04.397 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : getting bind: setUpnpService 2021-12-03 15:40:04.398 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Locating method setUpnpService in class org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService 2021-12-03 15:40:04.398 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : doFindMethod: Looking for method org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.setUpnpService 2021-12-03 15:40:04.399 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Declared Method org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.setUpnpService([interface org.osgi.framework.ServiceReference]) not found 2021-12-03 15:40:04.400 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Declared Method org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.setUpnpService([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-12-03 15:40:04.401 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : getReferenceClass: Looking for interface class org.jupnp.UpnpService through loader of org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService 2021-12-03 15:40:04.402 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : getParameterClass: Found class org.jupnp.UpnpService 2021-12-03 15:40:04.403 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : doFindMethod: No method taking ServiceReference found, checking method taking org.jupnp.UpnpService 2021-12-03 15:40:04.404 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : doFindMethod: Found Method protected void org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.setUpnpService(org.jupnp.UpnpService) 2021-12-03 15:40:04.404 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Found bind method: protected void org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.setUpnpService(org.jupnp.UpnpService) 2021-12-03 15:40:04.405 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : This thread collected dependencies 2021-12-03 15:40:04.406 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : getService (single component manager) dependencies collected. 2021-12-03 15:40:04.406 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state satisfied 2021-12-03 15:40:04.407 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Querying state satisfied 2021-12-03 15:40:04.408 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : For dependency UpnpService, optional: false; to bind: [[RefPair: ref: [{org.jupnp.UpnpService}={service.id=493, service.bundleid=260, service.scope=bundle, component.name=org.jupnp.upnpservice, component.id=315}] service: [org.jupnp.UpnpServiceImpl@190d510]]] 2021-12-03 15:40:04.409 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : invoking bind: setUpnpService: parameters [org.jupnp.UpnpServiceImpl] 2021-12-03 15:40:04.410 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : invoked bind: setUpnpService 2021-12-03 15:40:04.410 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : getting activate: activate 2021-12-03 15:40:04.411 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Locating method activate in class org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService 2021-12-03 15:40:04.412 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Declared Method org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-12-03 15:40:04.413 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Found activate method: public void org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService.activate() 2021-12-03 15:40:04.415 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : invoking activate: activate: parameters [] 2021-12-03 15:40:04.416 [DEBUG] [ernal.discovery.WemoDiscoveryService] - Starting WeMo UPnP discovery... 2021-12-03 15:40:04.417 [DEBUG] [ernal.discovery.WemoDiscoveryService] - Starting UPnP RootDevice search... 2021-12-03 15:40:04.419 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : invoked activate: activate 2021-12-03 15:40:04.420 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Set implementation object for component 2021-12-03 15:40:04.421 [DEBUG] [ernal.discovery.WemoDiscoveryService] - bundle org.openhab.binding.wemo:3.2.0.M4 (303)[org.openhab.binding.wemo.internal.discovery.WemoDiscoveryService(975)] : Changed state from satisfied to active