Hmm.  Svn updated today and rebuilt and it all worked.  Maybe it just
needed a good night's rest.  Thanks for the pointers on how to track
down problems in the future, Lin.

Regards, Graham.

2009/12/8 Lin Sun <[email protected]>:
> Hi Graham,
>
> You are right the end error is the same, but the cause is different.
> In your case, it failed at state WaitForNamespaceHandlers, as
> indicated by -
>
> [pool-1-thread-3] DEBUG
> org.apache.aries.blueprint.container.BlueprintContainerImpl - Running
> blueprint container for bundle org.apache.aries.blueprint.sample in
> state WaitForNamespaceHandlers
> [pool-1-thread-3] DEBUG
> org.apache.aries.blueprint.container.BlueprintEventDispatcher -
> Sending blueprint container event BlueprintEvent[type=GRACE_PERIOD,
> dependencies=[(&(objectClass=org.apache.aries.blueprint.NamespaceHandler)(osgi.service.blueprint.namespace=http://aries.apache.org/blueprint/xmlns/blueprint-ext/v1.0.0)),
> (&(objectClass=org.apache.aries.blueprint.NamespaceHandler)(osgi.service.blueprint.namespace=http://aries.apache.org/blueprint/xmlns/blueprint-cm/v1.0.0))]]
> for bundle org.apache.aries.blueprint.sample
>
> And I see that servicetracker did give 5 seconds before throw the
> "Gave up waiting for service" error.
>
> You may want to add a bit more debugger statement in
> BlueprintContainerImpl.doRun() or attach a debugger for this.  To
> attach a debugger, just uncomment out this line -
>
>            // 
> org.ops4j.pax.exam.container.def.PaxRunnerOptions.vmOption("-Xdebug
> -Xrunjdwp:transport=dt_socket,server=y,suspend=y,address=5005"),
>
>
> Lin
>
>
>
> On Tue, Dec 8, 2009 at 11:18 AM, Graham Charters
> <[email protected]> wrote:
>> Hi Lin, I'm not using Windows and I'm pretty sure it's not a firewall
>> problem.  The errors I see in the surefire-reports are the same as
>> those that Alasdair attached, but I've attached the one requested just
>> in case I'm missing something.
>>
>> Thanks, Graham.
>>
>> 2009/12/8 Lin Sun <[email protected]>:
>>> Hi Graham
>>>
>>> Looks like many itests produced ERROR (instead of FAILURE) for you.
>>> Could it be the same prob Mark mentioned in his email -
>>>
>>> http://www.mail-archive.com/[email protected]/msg00834.html
>>>
>>> If not, would it be possible to provide one of the failing tests'
>>> surefire logs (for example, BlueprintContainerTest)?
>>>
>>> HTH
>>> Lin
>>> On Tue, Dec 8, 2009 at 10:08 AM, Graham Charters
>>> <[email protected]> wrote:
>>>> Hi Lin, here's what I see in terms of passes/failures:
>>>>
>>>> -------------------------------------------------------
>>>>  T E S T S
>>>> -------------------------------------------------------
>>>> Running org.apache.aries.blueprint.itests.TestReferences
>>>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 177.978 sec
>>>> Running org.apache.aries.blueprint.itests.BlueprintContainer2Test
>>>> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed:
>>>> 365.992 sec <<< FAILURE!
>>>> Running 
>>>> org.apache.aries.blueprint.itests.BlueprintContainer2BTCustomizerTest
>>>> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 111.46
>>>> sec <<< FAILURE!
>>>> Running org.apache.aries.blueprint.itests.BlueprintContainerTest
>>>> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 99.948
>>>> sec <<< FAILURE!
>>>> Running 
>>>> org.apache.aries.blueprint.itests.BlueprintContainerBTCustomizerTest
>>>> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed:
>>>> 110.058 sec <<< FAILURE!
>>>> Running org.apache.aries.blueprint.itests.TestConfigAdmin
>>>> Tests run: 4, Failures: 0, Errors: 2, Skipped: 0, Time elapsed:
>>>> 381.777 sec <<< FAILURE!
>>>>
>>>> Results :
>>>>
>>>> Tests in error:
>>>>  testStrategyNone
>>>> [equinox/3.5.0](org.apache.aries.blueprint.itests.TestConfigAdmin)
>>>>  testStrategyComponent
>>>> [equinox/3.5.0](org.apache.aries.blueprint.itests.TestConfigAdmin)
>>>>
>>>> Tests run: 10, Failures: 0, Errors: 6, Skipped: 0
>>>>
>>>>
>>>> 2009/12/8 Lin Sun <[email protected]>:
>>>>> Hi,
>>>>>
>>>>> Can you please provide a bit more details?  Are you getting any of the
>>>>> blueprint itest passing or just this
>>>>> BlueprintContainer2BTCustomizerTest failing?
>>>>>
>>>>> BTW, the blueprint itests all pass in the hudson builds.
>>>>>
>>>>> Lin
>>>>>
>>>>> On Tue, Dec 8, 2009 at 9:27 AM, Graham Charters
>>>>> <[email protected]> wrote:
>>>>>> I'm also consistently seeing this problem. :-(
>>>>>>
>>>>>> 2009/12/7 Lin Sun <[email protected]>:
>>>>>>> Hi,
>>>>>>>
>>>>>>> thanks much for the log.  I am still not able to recreate it after
>>>>>>> many runs which made me to believe it is a timing prob.
>>>>>>>
>>>>>>> In looking at your logs, it seems right after (within a sec) the
>>>>>>> blueprint extender detects the blueprint sample, we throw this unable
>>>>>>> to get the blueprint container service for the blueprint sample error.
>>>>>>>  So I tried to wait a bit before we kick the test.  Hope it helped.
>>>>>>>
>>>>>>> Lin
>>>>>>>
>>>>>>> On Mon, Dec 7, 2009 at 9:58 AM, Alasdair Nottingham <[email protected]> 
>>>>>>> wrote:
>>>>>>>> I have rerun a few times and it isn't consistantly. Attached are the
>>>>>>>> logs from a failing run.
>>>>>>>>
>>>>>>>> Alasdair
>>>>>>>>
>>>>>>>> 2009/12/7 Lin Sun <[email protected]>:
>>>>>>>>> Hi,
>>>>>>>>>
>>>>>>>>> It worked for me.  Does this fail constantly for you?  If so, could
>>>>>>>>> you attach the surefire logs for this test?
>>>>>>>>>
>>>>>>>>> I think there is an intermittent blueprint itest failure that happens
>>>>>>>>> once a while on various blueprint itest which I don't have much clue
>>>>>>>>> yet.
>>>>>>>>>
>>>>>>>>> Lin
>>>>>>>>>
>>>>>>>>> On Mon, Dec 7, 2009 at 9:33 AM, Alasdair Nottingham <[email protected]> 
>>>>>>>>> wrote:
>>>>>>>>>> Hi,
>>>>>>>>>>
>>>>>>>>>> After doing an svn update I get the following error out of one of 
>>>>>>>>>> the itests:
>>>>>>>>>>
>>>>>>>>>> -------------------------------------------------------------------------------
>>>>>>>>>> Test set: 
>>>>>>>>>> org.apache.aries.blueprint.itests.BlueprintContainer2BTCustomizerTest
>>>>>>>>>> -------------------------------------------------------------------------------
>>>>>>>>>> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 5.591
>>>>>>>>>> sec <<< FAILURE!
>>>>>>>>>> test 
>>>>>>>>>> [equinox/3.5.0](org.apache.aries.blueprint.itests.BlueprintContainer2BTCustomizerTest)
>>>>>>>>>>  Time elapsed: 5.513 sec  <<< ERROR!
>>>>>>>>>> java.lang.RuntimeException: Gave up waiting for service
>>>>>>>>>> (&(objectClass=org.osgi.service.blueprint.container.BlueprintContainer)(osgi.blueprint.container.symbolicname=org.apache.aries.blueprint.sample))
>>>>>>>>>>        at 
>>>>>>>>>> org.apache.aries.blueprint.itests.AbstractIntegrationTest.getOsgiService(AbstractIntegrationTest.java:96)
>>>>>>>>>>        at 
>>>>>>>>>> org.apache.aries.blueprint.itests.AbstractIntegrationTest.getBlueprintContainerForBundle(AbstractIntegrationTest.java:65)
>>>>>>>>>>        at 
>>>>>>>>>> org.apache.aries.blueprint.itests.AbstractIntegrationTest.testBlueprintContainer(AbstractIntegrationTest.java:149)
>>>>>>>>>>        at 
>>>>>>>>>> org.apache.aries.blueprint.itests.BlueprintContainer2BTCustomizerTest.test(BlueprintContainer2BTCustomizerTest.java:105)
>>>>>>>>>>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>>>>>>>>>>        at java.lang.reflect.Method.invoke(Method.java:597)
>>>>>>>>>>        at 
>>>>>>>>>> org.ops4j.pax.exam.junit.extender.impl.internal.CallableTestMethodImpl.injectContextAndInvoke(CallableTestMethodImpl.java:134)
>>>>>>>>>>        at 
>>>>>>>>>> org.ops4j.pax.exam.junit.extender.impl.internal.CallableTestMethodImpl.call(CallableTestMethodImpl.java:101)
>>>>>>>>>>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>>>>>>>>>>        at java.lang.reflect.Method.invoke(Method.java:597)
>>>>>>>>>>        at 
>>>>>>>>>> org.ops4j.pax.exam.rbc.internal.RemoteBundleContextImpl.remoteCall(RemoteBundleContextImpl.java:80)
>>>>>>>>>>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>>>>>>>>>>        at 
>>>>>>>>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>>>>>>>>>>        at java.lang.reflect.Method.invoke(Method.java:597)
>>>>>>>>>>        at 
>>>>>>>>>> sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:305)
>>>>>>>>>>        at sun.rmi.transport.Transport$1.run(Transport.java:159)
>>>>>>>>>>        at java.security.AccessController.doPrivileged(Native Method)
>>>>>>>>>>        at sun.rmi.transport.Transport.serviceCall(Transport.java:155)
>>>>>>>>>>        at 
>>>>>>>>>> sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:535)
>>>>>>>>>>        at 
>>>>>>>>>> sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790)
>>>>>>>>>>        at 
>>>>>>>>>> sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649)
>>>>>>>>>>        at 
>>>>>>>>>> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
>>>>>>>>>>        at 
>>>>>>>>>> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
>>>>>>>>>>        at java.lang.Thread.run(Thread.java:637)
>>>>>>>>>>
>>>>>>>>>> Any one have any thoughts?
>>>>>>>>>> Alasdair
>>>>>>>>>>
>>>>>>>>>> --
>>>>>>>>>> Alasdair Nottingham
>>>>>>>>>> [email protected]
>>>>>>>>>>
>>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> --
>>>>>>>> Alasdair Nottingham
>>>>>>>> [email protected]
>>>>>>>>
>>>>>>>
>>>>>>
>>>>>
>>>>
>>>
>>
>

Reply via email to