Mailing-List: contact users-help@felix.apache.org; run by ezmlm
Precedence: bulk
Reply-To: users@felix.apache.org
Received-SPF: pass (athena.apache.org: domain of ajpurkiss@hotmail.com
 designates 65.54.190.221 as permitted sender)
Message-ID: <BAY165-W20983053FAF22B3771426FB1610@phx.gbl>
Content-Type: multipart/alternative;
	boundary="_0b52af6d-7e72-4ecd-b295-e5988886ccd9_"
From: Adam Purkiss <ajpurkiss@hotmail.com>
To: "users@felix.apache.org" <users@felix.apache.org>
Subject: RE: NPE from DependencyManager in scr code
Date: Wed, 17 Jul 2013 17:11:17 -0400
Importance: Normal
In-Reply-To: <DC20A9EA-4622-48D7-BE70-83346BB4C528@yahoo.com>
References: 
 <BAY165-W47FF7F56DBDFE587F7648CB1610@phx.gbl>,<DC20A9EA-4622-48D7-BE70-83346BB4C528@yahoo.com>
MIME-Version: 1.0

--_0b52af6d-7e72-4ecd-b295-e5988886ccd9_
Content-Type: text/plain; charset="iso-8859-1"
Content-Transfer-Encoding: quoted-printable

Sorry let me explain a little better. DependencyManager in this case is SCR=
 related. It was noted during startup that we see a failure to bind referen=
ce message and the stack trace has Caused by: java.lang.NullPointerExceptio=
n at org.apache.felix.scr.impl.manager.DependencyManager.invokeUnbindMethod=
(DependencyManager.java:1746)
What puzzled me at first is why during startup there would be a call to unb=
ind and where the NPE is coming from. The windows logger component is not m=
uch during activate or any of its set calls that I can see.
We have been running the trunk build as of end of May and this seems to be =
an intermittent issue that is not easy to reproduce. When I did an update a=
nd tried to build it I noticed that it took three attempts before it would =
build so I am not sure if there are real test issues or if the tests themse=
lves have issues. We can try to update to the last few changes made in July=
. If you have some thoughts on what could be up that would be good though.

> Subject: Re: NPE from DependencyManager in scr code
> From: david_jencks@yahoo.com
> Date: Wed=2C 17 Jul 2013 11:47:13 -0700
> To: users@felix.apache.org
>=20
> I'm not clear on what you are describing.  There's a DependencyManager cl=
ass in SCR and also a felix component called DependencyManager.  Also is th=
is problem in your code or while trying to build a felix component?
>=20
> If the problem is in SCR/DS could you try again with current trunk?  Poss=
ibly the problem already got fixed.
>=20
> thanks
> david jencks
>=20
> On Jul 17=2C 2013=2C at 11:39 AM=2C Adam Purkiss <ajpurkiss@hotmail.com> =
wrote:
>=20
> > We are noticing an intermittent issue with DependencyManager (build of =
1.7 snapshot with all changes up to and including May 29). Not sure what is=
 causing this behaviour. Does anyone have thoughts on what it might be? Are=
 we doing something wrong or is it a threading issue we are running into?  =
I tried to get the latest code built but I was finding that "mvn clean inst=
all" failed 2 out of 4 times=2C one with a test failure and one with a diff=
erent error to do with fail safe so I am not sure how safe the latest code =
changes are. I don't understand why at this point it is trying to do an unb=
ind as the system is starting up.
> > thanks
> >=20
> >=20
> > 2013.07.17 12:22:50.759 [ERROR]:
> > [com.nuance.docimg.dws.core.logprovider.impl.LogServiceImpl(15)] Cannot=
 create
> > component instance due to failure to bind reference WindowsLogger
> >=20
> > 2013.07.17 12:22:50.759 [ERROR]: FrameworkEvent ERROR
> >=20
> > org.apache.felix.log.LogException:
> > org.osgi.framework.ServiceException: Service factory exception: null
> >=20
> >=20
> > at
> > org.apache.felix.framework.ServiceRegistrationImpl.getFactoryUnchecked(=
ServiceRegistrationImpl.java:312)
> >=20
> >=20
> > at org.apache.felix.framework.ServiceRegistrationImpl.getService(Servic=
eRegistrationImpl.java:219)
> >=20
> >=20
> > at
> > org.apache.felix.framework.ServiceRegistry.getService(ServiceRegistry.j=
ava:320)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.getService(Felix.java:3568)
> >=20
> >=20
> > at
> > org.apache.felix.framework.BundleContextImpl.getService(BundleContextIm=
pl.java:468)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.helper.BindMethod.getServiceObject(BindMethod=
.java:572)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.DependencyManager.getServiceObject=
(DependencyManager.java:2072)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.DependencyManager$SingleDynamicCustom=
izer.prebind(DependencyManager.java:836)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.DependencyManager.prebind(Dependen=
cyManager.java:1406)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager.collectDepen=
dencies(AbstractComponentManager.java:1034)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.ImmediateComponentManager.getServi=
ceInternal(ImmediateComponentManager.java:736)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ImmediateComponentManager.getService(=
ImmediateComponentManager.java:706)
> >=20
> >=20
> > at org.apache.felix.framework.ServiceRegistrationImpl.getFactoryUncheck=
ed(ServiceRegistrationImpl.java:308)
> >=20
> >=20
> > at
> > org.apache.felix.framework.ServiceRegistrationImpl.getService(ServiceRe=
gistrationImpl.java:219)
> >=20
> >=20
> > at
> > org.apache.felix.framework.ServiceRegistry.getService(ServiceRegistry.j=
ava:320)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.getService(Felix.java:3568)
> >=20
> >=20
> > at
> > org.apache.felix.framework.BundleContextImpl.getService(BundleContextIm=
pl.java:468)
> >=20
> >=20
> > at org.apache.axis2.osgi.deployment.OSGiConfigurationContextFactory$Axi=
sConfigServiceListener.serviceChanged(OSGiConfigurationContextFactory.java:=
223)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.invokeServiceListenerCa=
llback(EventDispatcher.java:932)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.fireEventImmediately(Ev=
entDispatcher.java:793)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.fireServiceEvent(EventD=
ispatcher.java:543)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.fireServiceEvent(Felix.java:4419)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.registerService(Felix.java:3423)
> >=20
> >=20
> > at
> > org.apache.felix.framework.BundleContextImpl.registerService(BundleCont=
extImpl.java:346)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.registe=
r(AbstractComponentManager.java:919)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(A=
bstractComponentManager.java:908)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistra=
tion(RegistrationManager.java:134)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager.registerServ=
ice(AbstractComponentManager.java:960)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.AbstractComponentManager.activateI=
nternal(AbstractComponentManager.java:755)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.DependencyManager$SingleDynamicCustom=
izer.addedService(DependencyManager.java:709)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.DependencyManager$SingleDynamicCus=
tomizer.addedService(DependencyManager.java:655)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdde=
d(ServiceTracker.java:1477)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerA=
dded(ServiceTracker.java:1398)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.trackA=
dding(ServiceTracker.java:1210)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.tra=
ck(ServiceTracker.java:1148)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChanged=
(ServiceTracker.java:1429)
> >=20
> >=20
> > at org.apache.felix.framework.util.EventDispatcher.invokeServiceListene=
rCallback(EventDispatcher.java:932)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.fireEventImmediately(Ev=
entDispatcher.java:793)
> >=20
> >=20
> > at org.apache.felix.framework.util.EventDispatcher.fireServiceEvent(Eve=
ntDispatcher.java:543)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.fireServiceEvent(Felix.java:4419)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.registerService(Felix.java:3423)
> >=20
> >=20
> > at org.apache.felix.framework.BundleContextImpl.registerService(BundleC=
ontextImpl.java:346)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager$3.register(A=
bstractComponentManager.java:919)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.AbstractComponentManager$3.registe=
r(AbstractComponentManager.java:908)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.RegistrationManager.changeRegistratio=
n(RegistrationManager.java:134)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager.registerServ=
ice(AbstractComponentManager.java:960)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.AbstractComponentManager.activateInte=
rnal(AbstractComponentManager.java:755)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.DependencyManager$SingleDynamicCustom=
izer.addedService(DependencyManager.java:709)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.DependencyManager$SingleDynamicCustom=
izer.addedService(DependencyManager.java:655)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdde=
d(ServiceTracker.java:1477)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.customizerAdde=
d(ServiceTracker.java:1398)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.tra=
ckAdding(ServiceTracker.java:1210)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceTracker$AbstractTracked.track(=
ServiceTracker.java:1148)
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.ServiceTracker$Tracked.serviceChan=
ged(ServiceTracker.java:1429)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.invokeServiceListenerCa=
llback(EventDispatcher.java:932)
> >=20
> >=20
> > at org.apache.felix.framework.util.EventDispatcher.fireEventImmediately=
(EventDispatcher.java:793)
> >=20
> >=20
> > at
> > org.apache.felix.framework.util.EventDispatcher.fireServiceEvent(EventD=
ispatcher.java:543)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.fireServiceEvent(Felix.java:4419)
> >=20
> >=20
> > at org.apache.felix.framework.Felix.registerService(Felix.java:3423)
> >=20
> >=20
> > at
> > org.apache.felix.framework.BundleContextImpl.registerService(BundleCont=
extImpl.java:346)
> >=20
> >=20
> > at org.apache.felix.http.base.internal.HttpServiceController.register(H=
ttpServiceController.java:135)
> >=20
> >=20
> > at
> > org.apache.felix.http.base.internal.DispatcherServlet.init(DispatcherSe=
rvlet.java:48)
> >=20
> >=20
> > at
> > org.apache.felix.http.proxy.DispatcherTracker.initDispatcher(Dispatcher=
Tracker.java:97)
> >=20
> >=20
> > at
> > org.apache.felix.http.proxy.DispatcherTracker.setDispatcher(DispatcherT=
racker.java:77)
> >=20
> >=20
> > at
> > org.apache.felix.http.proxy.DispatcherTracker.addingService(DispatcherT=
racker.java:52)
> >=20
> >=20
> > at org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(Servic=
eTracker.java:932)
> >=20
> >=20
> > at
> > org.osgi.util.tracker.ServiceTracker$Tracked.customizerAdding(ServiceTr=
acker.java:864)
> >=20
> >=20
> > at org.osgi.util.tracker.AbstractTracked.trackAdding(AbstractTracked.ja=
va:256)
> >=20
> >=20
> > at org.osgi.util.tracker.AbstractTracked.trackInitial(AbstractTracked.j=
ava:183)
> >=20
> >=20
> > at org.osgi.util.tracker.ServiceTracker.open(ServiceTracker.java:317)
> >=20
> >=20
> > at org.osgi.util.tracker.ServiceTracker.open(ServiceTracker.java:261)
> >=20
> >=20
> > at org.apache.felix.http.proxy.ProxyServlet.doInit(ProxyServlet.java:51=
)
> >=20
> >=20
> > at org.apache.felix.http.proxy.ProxyServlet.init(ProxyServlet.java:39)
> >=20
> >=20
> > at org.apache.catalina.core.StandardWrapper.initServlet(StandardWrapper=
.java:1280)
> >=20
> >=20
> > at
> > org.apache.catalina.core.StandardWrapper.loadServlet(StandardWrapper.ja=
va:1193)
> >=20
> >=20
> > at org.apache.catalina.core.StandardWrapper.load(StandardWrapper.java:1=
088)
> >=20
> >=20
> > at
> > org.apache.catalina.core.StandardContext.loadOnStartup(StandardContext.=
java:5123)
> >=20
> >=20
> > at
> > org.apache.catalina.core.StandardContext.startInternal(StandardContext.=
java:5407)
> >=20
> >=20
> > at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
> >=20
> >=20
> > at
> > org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.ja=
va:1559)
> >=20
> >=20
> > at
> > org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.ja=
va:1549)
> >=20
> >=20
> > at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> >=20
> >=20
> > at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> >=20
> >=20
> > at
> > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.ja=
va:1145)
> >=20
> >=20
> > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecuto=
r.java:615)
> >=20
> >=20
> > at java.lang.Thread.run(Thread.java:722)
> >=20
> > Caused by: java.lang.NullPointerException
> >=20
> >=20
> > at org.apache.felix.scr.impl.manager.DependencyManager.invokeUnbindMeth=
od(DependencyManager.java:1746)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.DependencyManager.close(DependencyMan=
ager.java:1500)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ImmediateComponentManager.createImple=
mentationObject(ImmediateComponentManager.java:276)
> >=20
> >=20
> > at
> > org.apache.felix.scr.impl.manager.ServiceFactoryComponentManager.getSer=
vice(ServiceFactoryComponentManager.java:139)
> >=20
> >=20
> > at
> > org.apache.felix.framework.ServiceRegistrationImpl.getFactoryUnchecked(=
ServiceRegistrationImpl.java:308)
> >=20
> >=20
> > ... 85 more 		 	   		 =20
>=20
>=20
> ---------------------------------------------------------------------
> To unsubscribe=2C e-mail: users-unsubscribe@felix.apache.org
> For additional commands=2C e-mail: users-help@felix.apache.org
>=20
 		 	   		  =

--_0b52af6d-7e72-4ecd-b295-e5988886ccd9_--