2021-09-03 09:48:27.723 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'plex:server:16d955dc66' changed from OFFLINE (CONFIGURATION_ERROR): Unable to fetch API, token may be wrong? to UNINITIALIZED 2021-09-03 09:48:27.739 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'plex:server:16d955dc66' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR) 2021-09-03 09:48:27.927 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'plex:server:16d955dc66' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING 2021-09-03 09:48:28.150 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'plex:server:16d955dc66' changed from INITIALIZING to OFFLINE (CONFIGURATION_ERROR): Unable to fetch API, token may be wrong? ==> /var/log/openhab/openhab.log <== 2021-09-03 09:48:27.712 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Querying state active 2021-09-03 09:48:27.714 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Deactivating component 2021-09-03 09:48:27.715 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : registration change queue [unregistered] 2021-09-03 09:48:27.730 [DEBUG] [x.internal.handler.PlexServerHandler] - Disposing PLEX Bridge Handler. 2021-09-03 09:48:27.738 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Querying state active 2021-09-03 09:48:27.740 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : getting deactivate: deactivate 2021-09-03 09:48:27.742 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Locating method deactivate in class org.openhab.binding.plex.internal.PlexHandlerFactory 2021-09-03 09:48:27.742 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Declared Method org.openhab.binding.plex.internal.PlexHandlerFactory.deactivate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.743 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Locating method deactivate in class org.openhab.core.thing.binding.BaseThingHandlerFactory 2021-09-03 09:48:27.744 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Found deactivate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.deactivate(org.osgi.service.component.ComponentContext) 2021-09-03 09:48:27.744 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : invoking deactivate: deactivate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-09-03 09:48:27.745 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : invoked deactivate: deactivate 2021-09-03 09:48:27.746 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : DependencyManager: $000 close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@812dd at tracking count 1 refpairs: [[RefPair: ref: [{org.openhab.core.thing.type.DynamicStateDescriptionProvider, org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider}={service.id=627, service.bundleid=301, service.scope=bundle, component.name=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, component.id=367}] service: [org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider@115de84]]] 2021-09-03 09:48:27.747 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified 2021-09-03 09:48:27.747 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Changed state from active to satisfied 2021-09-03 09:48:27.748 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Deactivating dependency managers 2021-09-03 09:48:27.749 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Disabling dependency managers 2021-09-03 09:48:27.750 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : unregistering service listener for dependency $000 2021-09-03 09:48:27.751 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Querying state satisfied 2021-09-03 09:48:27.752 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Changed state from satisfied to disposed 2021-09-03 09:48:27.752 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(366)] : Disposing component (reason: 6) 2021-09-03 09:48:27.753 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Querying state active 2021-09-03 09:48:27.754 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Deactivating component 2021-09-03 09:48:27.754 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : registration change queue [unregistered] 2021-09-03 09:48:27.756 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Querying state active 2021-09-03 09:48:27.757 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : getting deactivate: deactivate 2021-09-03 09:48:27.757 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Locating method deactivate in class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.758 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.deactivate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.759 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Locating method deactivate in class org.openhab.core.thing.binding.BaseDynamicStateDescriptionProvider 2021-09-03 09:48:27.760 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Declared Method org.openhab.core.thing.binding.BaseDynamicStateDescriptionProvider.deactivate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.760 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Found deactivate method: public void org.openhab.core.thing.binding.BaseDynamicStateDescriptionProvider.deactivate() 2021-09-03 09:48:27.761 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : invoking deactivate: deactivate: parameters [] 2021-09-03 09:48:27.762 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : invoked deactivate: deactivate 2021-09-03 09:48:27.762 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : DependencyManager: ChannelTypeI18nLocalizationService close component unbinding from org.apache.felix.scr.impl.manager.ComponentContextImpl@6c423b at tracking count 1 refpairs: [[RefPair: ref: [{org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService}={service.id=364, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService, component.id=227}] service: [org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService@19dbf77]]] 2021-09-03 09:48:27.763 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : getting unbind: unsetChannelTypeI18nLocalizationService 2021-09-03 09:48:27.764 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Locating method unsetChannelTypeI18nLocalizationService in class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.764 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : doFindMethod: Looking for method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.unsetChannelTypeI18nLocalizationService 2021-09-03 09:48:27.765 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.unsetChannelTypeI18nLocalizationService([interface org.osgi.framework.ServiceReference]) not found 2021-09-03 09:48:27.765 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.unsetChannelTypeI18nLocalizationService([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-09-03 09:48:27.766 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : getReferenceClass: Looking for interface class org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService through loader of org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.766 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : getParameterClass: Found class org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.767 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.768 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : doFindMethod: Found Method protected void org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.unsetChannelTypeI18nLocalizationService(org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService) 2021-09-03 09:48:27.768 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Found unbind method: protected void org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.unsetChannelTypeI18nLocalizationService(org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService) 2021-09-03 09:48:27.769 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : invoking unbind: unsetChannelTypeI18nLocalizationService: parameters [org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService] 2021-09-03 09:48:27.769 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : invoked unbind: unsetChannelTypeI18nLocalizationService 2021-09-03 09:48:27.770 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Unset and deconfigured implementation object for component in deleteComponent for reason Unspecified 2021-09-03 09:48:27.770 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Changed state from active to satisfied 2021-09-03 09:48:27.771 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Deactivating dependency managers 2021-09-03 09:48:27.772 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Disabling dependency managers 2021-09-03 09:48:27.772 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : unregistering service listener for dependency ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.773 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Querying state satisfied 2021-09-03 09:48:27.774 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Changed state from satisfied to disposed 2021-09-03 09:48:27.774 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(367)] : Disposing component (reason: 6) 2021-09-03 09:48:27.806 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : BundleComponentActivator : ComponentHolder created. 2021-09-03 09:48:27.807 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : BundleComponentActivator : ComponentHolder created. 2021-09-03 09:48:27.809 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Dependency Manager created $000interface=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, filter=null, policy=static, cardinality=1..1, bind=null, unbind=null, updated=null, field=null, field-option=null, collection-type=null, parameter=0 2021-09-03 09:48:27.810 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Component created: DS=DS14, implementation=org.openhab.binding.plex.internal.PlexHandlerFactory, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[binding.plex] 2021-09-03 09:48:27.811 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Component Services: scope=singleton, services=[org.openhab.core.thing.binding.ThingHandlerFactory] 2021-09-03 09:48:27.811 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Component Properties: {} 2021-09-03 09:48:27.812 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Querying state disabled 2021-09-03 09:48:27.813 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Querying state disabled 2021-09-03 09:48:27.813 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Component can not be activated since it is in state disabled 2021-09-03 09:48:27.814 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory] : Querying state disabled 2021-09-03 09:48:27.814 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Updating target filters 2021-09-03 09:48:27.815 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : No change in target property for dependency $000: currently registered: false 2021-09-03 09:48:27.816 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : No existing service listener to unregister for dependency $000 2021-09-03 09:48:27.816 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Setting target property for dependency $000 to null 2021-09-03 09:48:27.817 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : New service tracker for $000, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider), initialReferenceFilter (objectClass=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider) 2021-09-03 09:48:27.818 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : dm $000 tracker reset (closed) 2021-09-03 09:48:27.819 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : dm $000 tracker opened 2021-09-03 09:48:27.820 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : registering service listener for dependency $000 2021-09-03 09:48:27.821 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Changed state from disabled to unsatisfiedReference 2021-09-03 09:48:27.821 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Component enabled 2021-09-03 09:48:27.822 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : ActivateInternal 2021-09-03 09:48:27.823 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.824 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.824 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Activating component from state unsatisfiedReference 2021-09-03 09:48:27.825 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.826 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.827 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Dependency not satisfied: $000 2021-09-03 09:48:27.827 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Not all dependencies satisfied, cannot activate 2021-09-03 09:48:27.828 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Dependency Manager created ChannelTypeI18nLocalizationServiceinterface=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService, filter=null, policy=static, cardinality=1..1, bind=setChannelTypeI18nLocalizationService, unbind=unsetChannelTypeI18nLocalizationService, updated=null, field=null, field-option=null, collection-type=null, parameter=null 2021-09-03 09:48:27.829 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Component created: DS=DS13, implementation=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, immediate=false, default-enabled=true, factory=null, configuration-policy=optional, activate=activate, deactivate=deactivate, modified=null configuration-pid=[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] 2021-09-03 09:48:27.830 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Component Services: scope=singleton, services=[org.openhab.core.thing.type.DynamicStateDescriptionProvider, org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] 2021-09-03 09:48:27.831 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Component Properties: {} 2021-09-03 09:48:27.831 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Querying state disabled 2021-09-03 09:48:27.832 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Querying state disabled 2021-09-03 09:48:27.833 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Component can not be activated since it is in state disabled 2021-09-03 09:48:27.834 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider] : Querying state disabled 2021-09-03 09:48:27.834 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Updating target filters 2021-09-03 09:48:27.835 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : No change in target property for dependency ChannelTypeI18nLocalizationService: currently registered: false 2021-09-03 09:48:27.836 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : No existing service listener to unregister for dependency ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.837 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Setting target property for dependency ChannelTypeI18nLocalizationService to null 2021-09-03 09:48:27.838 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : New service tracker for ChannelTypeI18nLocalizationService, initial active: false, previous references: {}, classFilter: (objectClass=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService), initialReferenceFilter (objectClass=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService) 2021-09-03 09:48:27.838 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : dm ChannelTypeI18nLocalizationService tracker reset (closed) 2021-09-03 09:48:27.841 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : dm ChannelTypeI18nLocalizationService tracking 1 SingleStatic added {org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService}={service.id=364, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService, component.id=227} (enter) 2021-09-03 09:48:27.842 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : dm ChannelTypeI18nLocalizationService tracking 1 SingleStatic active: false trackerOpened: false optional: false 2021-09-03 09:48:27.843 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : dm ChannelTypeI18nLocalizationService tracking 1 SingleStatic added {org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService}={service.id=364, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService, component.id=227} (exit) 2021-09-03 09:48:27.844 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : dm ChannelTypeI18nLocalizationService tracker opened 2021-09-03 09:48:27.844 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : registering service listener for dependency ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.845 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Changed state from disabled to unsatisfiedReference 2021-09-03 09:48:27.846 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Component enabled 2021-09-03 09:48:27.846 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : ActivateInternal 2021-09-03 09:48:27.847 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.847 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.848 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Activating component from state unsatisfiedReference 2021-09-03 09:48:27.848 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.849 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.850 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Changed state from unsatisfiedReference to satisfied 2021-09-03 09:48:27.850 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : registration change queue [registered] 2021-09-03 09:48:27.852 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Checking constructor public org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider() 2021-09-03 09:48:27.853 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Found constructor with 0 arguments : public org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider() 2021-09-03 09:48:27.854 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : getting bind: setChannelTypeI18nLocalizationService 2021-09-03 09:48:27.854 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Locating method setChannelTypeI18nLocalizationService in class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.855 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : doFindMethod: Looking for method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.setChannelTypeI18nLocalizationService 2021-09-03 09:48:27.855 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.setChannelTypeI18nLocalizationService([interface org.osgi.framework.ServiceReference]) not found 2021-09-03 09:48:27.856 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.setChannelTypeI18nLocalizationService([interface org.osgi.service.component.ComponentServiceObjects]) not found 2021-09-03 09:48:27.857 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : getReferenceClass: Looking for interface class org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService through loader of org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.857 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : getParameterClass: Found class org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.858 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : doFindMethod: No method taking ServiceReference found, checking method taking org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService 2021-09-03 09:48:27.858 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : doFindMethod: Found Method protected void org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.setChannelTypeI18nLocalizationService(org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService) 2021-09-03 09:48:27.859 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Found bind method: protected void org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.setChannelTypeI18nLocalizationService(org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService) 2021-09-03 09:48:27.859 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : This thread collected dependencies 2021-09-03 09:48:27.860 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : getService (single component manager) dependencies collected. 2021-09-03 09:48:27.860 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state satisfied 2021-09-03 09:48:27.861 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Querying state satisfied 2021-09-03 09:48:27.862 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : For dependency ChannelTypeI18nLocalizationService, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService}={service.id=364, service.bundleid=213, service.scope=bundle, component.name=org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService, component.id=227}] service: [org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService@19dbf77]]] 2021-09-03 09:48:27.862 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : invoking bind: setChannelTypeI18nLocalizationService: parameters [org.openhab.core.thing.i18n.ChannelTypeI18nLocalizationService] 2021-09-03 09:48:27.863 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : invoked bind: setChannelTypeI18nLocalizationService 2021-09-03 09:48:27.864 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : getting activate: activate 2021-09-03 09:48:27.864 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Locating method activate in class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.865 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Declared Method org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.865 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Locating method activate in class org.openhab.core.thing.binding.BaseDynamicStateDescriptionProvider 2021-09-03 09:48:27.866 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Declared Method org.openhab.core.thing.binding.BaseDynamicStateDescriptionProvider.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.866 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Locating method activate in class org.openhab.core.thing.binding.AbstractDynamicDescriptionProvider 2021-09-03 09:48:27.867 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Found activate method: protected void org.openhab.core.thing.binding.AbstractDynamicDescriptionProvider.activate(org.osgi.service.component.ComponentContext) 2021-09-03 09:48:27.868 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-09-03 09:48:27.868 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : invoked activate: activate 2021-09-03 09:48:27.869 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Set implementation object for component 2021-09-03 09:48:27.869 [DEBUG] [l.PlexStateDescriptionOptionProvider] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider(369)] : Changed state from satisfied to active 2021-09-03 09:48:27.870 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : dm $000 tracking 1 SingleStatic added {org.openhab.core.thing.type.DynamicStateDescriptionProvider, org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider}={service.id=630, service.bundleid=301, service.scope=bundle, component.name=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, component.id=369} (enter) 2021-09-03 09:48:27.871 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : ActivateInternal 2021-09-03 09:48:27.872 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.872 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.873 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Activating component from state unsatisfiedReference 2021-09-03 09:48:27.874 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.874 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state unsatisfiedReference 2021-09-03 09:48:27.875 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Changed state from unsatisfiedReference to satisfied 2021-09-03 09:48:27.875 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : registration change queue [registered] 2021-09-03 09:48:27.877 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Checking constructor public org.openhab.binding.plex.internal.PlexHandlerFactory(org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider) 2021-09-03 09:48:27.878 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : getReferenceClass: Looking for interface class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider through loader of org.openhab.binding.plex.internal.PlexHandlerFactory 2021-09-03 09:48:27.878 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : getParameterClass: Found class org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider 2021-09-03 09:48:27.879 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Found constructor with 1 arguments : public org.openhab.binding.plex.internal.PlexHandlerFactory(org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider) 2021-09-03 09:48:27.880 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : This thread collected dependencies 2021-09-03 09:48:27.880 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : getService (single component manager) dependencies collected. 2021-09-03 09:48:27.881 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state satisfied 2021-09-03 09:48:27.881 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Querying state satisfied 2021-09-03 09:48:27.882 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : For dependency $000, optional: false; to bind: [[RefPair: ref: [{org.openhab.core.thing.type.DynamicStateDescriptionProvider, org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider}={service.id=630, service.bundleid=301, service.scope=bundle, component.name=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, component.id=369}] service: [null]]] 2021-09-03 09:48:27.883 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : getting activate: activate 2021-09-03 09:48:27.883 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Locating method activate in class org.openhab.binding.plex.internal.PlexHandlerFactory 2021-09-03 09:48:27.884 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Declared Method org.openhab.binding.plex.internal.PlexHandlerFactory.activate([interface org.osgi.service.component.ComponentContext]) not found 2021-09-03 09:48:27.885 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Locating method activate in class org.openhab.core.thing.binding.BaseThingHandlerFactory 2021-09-03 09:48:27.885 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Found activate method: protected void org.openhab.core.thing.binding.BaseThingHandlerFactory.activate(org.osgi.service.component.ComponentContext) 2021-09-03 09:48:27.886 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : invoking activate: activate: parameters [org.apache.felix.scr.impl.manager.ComponentContextImpl] 2021-09-03 09:48:27.887 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : invoked activate: activate 2021-09-03 09:48:27.887 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Set implementation object for component 2021-09-03 09:48:27.888 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : Changed state from satisfied to active 2021-09-03 09:48:27.890 [DEBUG] [ing.plex.internal.PlexHandlerFactory] - bundle org.openhab.binding.plex:3.1.0.202108041914 (301)[org.openhab.binding.plex.internal.PlexHandlerFactory(368)] : dm $000 tracking 1 SingleStatic added {org.openhab.core.thing.type.DynamicStateDescriptionProvider, org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider}={service.id=630, service.bundleid=301, service.scope=bundle, component.name=org.openhab.binding.plex.internal.PlexStateDescriptionOptionProvider, component.id=369} (exit) 2021-09-03 09:48:28.147 [DEBUG] [x.internal.handler.PlexServerHandler] - Unable to fetch API, token may be wrong?