JBI itests' ManagementTest intermittently fails on slower CI build machines
---------------------------------------------------------------------------
Key: SMX4NMR-181
URL: https://issues.apache.org/activemq/browse/SMX4NMR-181
Project: ServiceMix NMR
Issue Type: Test
Affects Versions: 1.0.0
Reporter: Gert Vanthienen
Assignee: Gert Vanthienen
Fix For: 1.2.0
On slower CI build machines, the JBI itests' ManagementTest intermittently
fails. From the log, it looks like it's a pure timing issue - the
AdminCommandsService is being registered at almost the exact same moment that
the test gives up waiting for it.
{noformat}
[12:18:56]: [pool-2-thread-3] DEBUG
org.apache.geronimo.blueprint.container.ServiceRecipe - Registering service
.component-4 with interfaces
[org.apache.servicemix.jbi.deployer.AdminCommandsService] and properties
{osgi.service.blueprint.compname=adminCommandsService}
[12:18:56]: [pool-2-thread-3] DEBUG
org.apache.geronimo.blueprint.container.ServiceRecipe - Retrieving service for
bundle pax-exam-probe_0.0.0 [57] and service registration
{org.apache.servicemix.jbi.deployer.AdminCommandsService}={osgi.service.blueprint.compname=adminCommandsService,
service.id=80}
[12:18:56]: [pool-2-thread-3] DEBUG
org.apache.geronimo.blueprint.container.ServiceRecipe - Creating service
instance
[12:18:56]: [SpringOsgiExtenderThread-1] DEBUG
org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver - Loaded
mappings [{}]
[12:18:56]: [SpringOsgiExtenderThread-1] DEBUG
org.springframework.osgi.extender.internal.support.NamespacePlugins - Trying to
resolving namespace handler for http://www.springframework.org/schema/osgi
[12:18:57]: [SpringOsgiExtenderThread-1] DEBUG
org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver - Loaded
mappings
[{http://www.springframework.org/schema/lang=org.springframework.scripting.config.LangNamespaceHandler,
http://www.springframework.org/schema/jee=org.springframework.ejb.config.JeeNamespaceHandler,
http://www.springframework.org/schema/context=org.springframework.context.config.ContextNamespaceHandler}]
[12:18:57]: [SpringOsgiExtenderThread-1] DEBUG
org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver - Loaded
mappings
[{http://www.springframework.org/schema/p=org.springframework.beans.factory.xml.SimplePropertyNamespaceHandler,
http://www.springframework.org/schema/util=org.springframework.beans.factory.xml.UtilNamespaceHandler}]
[12:18:58]: [SpringOsgiExtenderThread-1] DEBUG
org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver - Loaded
mappings
[{http://www.springframework.org/schema/osgi-compendium=org.springframework.osgi.compendium.config.CompendiumNamespaceHandler,
http://www.springframework.org/schema/osgi=org.springframework.osgi.config.OsgiNamespaceHandler}]
[12:18:58]: [pool-2-thread-1] DEBUG org.apache.servicemix.nmr.osgi -
ServiceEvent REGISTERED
[12:18:58]: [pool-2-thread-1] DEBUG
org.apache.geronimo.blueprint.container.BlueprintContainerImpl - Instantiating
components: [blueprintContainer, blueprintBundle, blueprintBundleContext,
blueprintConverter, .component-1, servicemix, .component-2, managementStrategy,
flowRegistry, endpointTracker, listenerRegistry, .component-3,
endpointRegistry, internalEndpointRegistry, .component-4, wireRegistry,
.component-5, authorizationService, .component-6, authorizationEntries,
.component-7, authenticationService, .component-8, executorFactory,
org.apache.geronimo.managedObjectManager, .cm-4]
[12:18:58]: [RMI TCP Connection(1)-10.65.4.7] DEBUG sun.rmi.server.call - RMI
TCP Connection(1)-10.65.4.7: [10.65.4.7] exception:
[12:18:58]: java.lang.reflect.InvocationTargetException
[12:18:58]: at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[12:18:58]: at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:48)
[12:18:59]: at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
[12:18:59]: at java.lang.reflect.Method.invoke(Method.java:600)
[12:18:59]: at
org.ops4j.pax.exam.rbc.internal.RemoteBundleContextImpl.remoteCall(RemoteBundleContextImpl.java:80)
[12:18:59]: at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[12:18:59]: at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:48)
[12:18:59]: at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
[12:18:59]: at java.lang.reflect.Method.invoke(Method.java:600)
[12:18:59]: at
sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:310)
[12:18:59]: at sun.rmi.transport.Transport$1.run(Transport.java:171)
[12:18:59]: at
java.security.AccessController.doPrivileged(AccessController.java:284)
[12:18:59]: at sun.rmi.transport.Transport.serviceCall(Transport.java:167)
[12:18:59]: at
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:547)
[12:18:59]: at
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:802)
[12:18:59]: at
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:661)
[12:19:00]: at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
[12:19:00]: at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
[12:19:00]: at java.lang.Thread.run(Thread.java:736)
[12:19:00]: Caused by: java.lang.reflect.InvocationTargetException
[12:19:00]: at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[12:19:00]: at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:48)
[12:19:00]: at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
[12:19:00]: at java.lang.reflect.Method.invoke(Method.java:600)
[12:19:00]: at
org.ops4j.pax.exam.junit.extender.impl.internal.CallableTestMethodImpl.injectContextAndInvoke(CallableTestMethodImpl.java:134)
[12:19:00]: at
org.ops4j.pax.exam.junit.extender.impl.internal.CallableTestMethodImpl.call(CallableTestMethodImpl.java:101)
[12:19:00]: ... 19 more
[12:19:00]: Caused by: java.lang.RuntimeException: Gave up waiting for service
(objectClass=org.apache.servicemix.jbi.deployer.AdminCommandsService)
[12:19:01]: at
org.apache.servicemix.jbi.itests.AbstractIntegrationTest.getOsgiService(AbstractIntegrationTest.java:91)
[12:19:01]: at
org.apache.servicemix.jbi.itests.AbstractIntegrationTest.getOsgiService(AbstractIntegrationTest.java:49)
[12:19:01]: at
org.apache.servicemix.jbi.itests.ManagementTest.getAdminCommands(ManagementTest.java:137)
[12:19:01]: at
org.apache.servicemix.jbi.itests.ManagementTest.testInstallUninstall(ManagementTest.java:64)
[12:19:01]: ... 25 more
{noformat}
--
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.
