Regression

org.eclipse.virgo.kernel.smoketest.KernelSmokeTests.virgoKernelShouldBeStarted

Failing for the past 1 build (Since Failed#17 )
Took 1 min 0 sec.

Error Message

java.lang.AssertionError: Server 'kernel' not started properly.

Stacktrace

java.lang.AssertionError: Server 'kernel' not started properly.
	at org.junit.Assert.fail(Assert.java:91)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.eclipse.virgo.test.tools.AbstractSmokeTests.startServer(AbstractSmokeTests.java:52)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:27)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.runTestClass(JUnitTestClassExecuter.java:86)
	at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecuter.execute(JUnitTestClassExecuter.java:49)
	at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassProcessor.processTestClass(JUnitTestClassProcessor.java:69)
	at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:48)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
	at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
	at org.gradle.messaging.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:32)
	at org.gradle.messaging.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:93)
	at com.sun.proxy.$Proxy2.processTestClass(Unknown Source)
	at org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:105)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:35)
	at org.gradle.messaging.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
	at org.gradle.messaging.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:355)
	at org.gradle.internal.concurrent.DefaultExecutorFactory$StoppableExecutorImpl$1.run(DefaultExecutorFactory.java:64)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)

Standard Output

Java HotSpot(TM) Server VM warning: ignoring option MaxPermSize=512m; support was removed in 8.0
javax.management.InstanceNotFoundException: org.eclipse.virgo.kernel:type=Shutdown
	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1095)
	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassLoaderFor(DefaultMBeanServerInterceptor.java:1444)
	at com.sun.jmx.mbeanserver.JmxMBeanServer.getClassLoaderFor(JmxMBeanServer.java:1324)
	at com.sun.jmx.remote.security.MBeanServerAccessController.getClassLoaderFor(MBeanServerAccessController.java:350)
	at javax.management.remote.rmi.RMIConnectionImpl$5.run(RMIConnectionImpl.java:1363)
	at java.security.AccessController.doPrivileged(Native Method)
	at javax.management.remote.rmi.RMIConnectionImpl.getClassLoaderFor(RMIConnectionImpl.java:1360)
	at javax.management.remote.rmi.RMIConnectionImpl.invoke(RMIConnectionImpl.java:811)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:323)
	at sun.rmi.transport.Transport$1.run(Transport.java:200)
	at sun.rmi.transport.Transport$1.run(Transport.java:197)
	at java.security.AccessController.doPrivileged(Native Method)
	at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
	at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:568)
	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:826)
	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$241(TCPTransport.java:683)
	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler$$Lambda$1/2587769.run(Unknown Source)
	at java.security.AccessController.doPrivileged(Native Method)
	at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:682)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)
	at sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:276)
	at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:253)
	at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:162)
	at com.sun.jmx.remote.internal.PRef.invoke(Unknown Source)
	at javax.management.remote.rmi.RMIConnectionImpl_Stub.invoke(Unknown Source)
	at javax.management.remote.rmi.RMIConnector$RemoteMBeanServerConnection.invoke(RMIConnector.java:1022)
	at org.eclipse.virgo.nano.shutdown.ShutdownClient.doShutdown(ShutdownClient.java:72)
	at org.eclipse.virgo.nano.shutdown.ShutdownClient.performShutdown(ShutdownClient.java:50)
	at org.eclipse.virgo.nano.shutdown.ShutdownClient.main(ShutdownClient.java:43)
[2015-06-08 05:44:13.868] startup-tracker              <KE0001I> Kernel starting. 
Current kernel status: 'STARTING'
Current kernel status: 'STARTING'
Current kernel status: 'STARTING'
[2015-06-08 05:44:15.993] startup-tracker              <KE0002I> Kernel started. 
[2015-06-08 05:44:16.149] system-artifacts             <DE0000I> Installing plan 'org.eclipse.virgo.kernel.userregion.blueprint' version '3.7.0'. 
[2015-06-08 05:44:16.636] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.gemini.blueprint.core' version '2.0.0.M02'. 
[2015-06-08 05:44:16.723] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.gemini.blueprint.extender' version '2.0.0.M02'. 
[2015-06-08 05:44:16.733] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.gemini.blueprint.io' version '2.0.0.M02'. 
[2015-06-08 05:44:16.739] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.virgo.kernel.agent.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:16.743] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.virgo.kernel.deployer.dm' version '3.7.0.D-20150608092334'. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:17.077] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.equinox.ds' version '1.4.0.v20120112-1400'. 
[2015-06-08 05:44:17.092] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.equinox.util' version '1.0.300.v20111010-1614'. 
[2015-06-08 05:44:17.098] system-artifacts             <DE0000I> Installing configuration 'osgi.console' version '0.0.0'. 
[2015-06-08 05:44:17.956] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.gemini.blueprint.core' version '2.0.0.M02'. 
[2015-06-08 05:44:17.957] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.gemini.blueprint.extender' version '2.0.0.M02'. 
[2015-06-08 05:44:17.958] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.gemini.blueprint.io' version '2.0.0.M02'. 
[2015-06-08 05:44:17.959] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.virgo.kernel.agent.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:17.960] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.virgo.kernel.deployer.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:17.962] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.equinox.ds' version '1.4.0.v20120112-1400'. 
[2015-06-08 05:44:17.964] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.equinox.util' version '1.0.300.v20111010-1614'. 
[2015-06-08 05:44:17.965] system-artifacts             <DE0001I> Installed configuration 'osgi.console' version '0.0.0'. 
[2015-06-08 05:44:17.965] system-artifacts             <DE0001I> Installed plan 'org.eclipse.virgo.kernel.userregion.blueprint' version '3.7.0'. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:17.988] system-artifacts             <DE0004I> Starting plan 'org.eclipse.virgo.kernel.userregion.blueprint' version '3.7.0'. 
[2015-06-08 05:44:17.993] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.gemini.blueprint.core' version '2.0.0.M02'. 
[2015-06-08 05:44:17.995] start-signalling-1           <DE0005I> Started bundle 'org.eclipse.gemini.blueprint.core' version '2.0.0.M02'. 
[2015-06-08 05:44:17.997] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.gemini.blueprint.extender' version '2.0.0.M02'. 
[2015-06-08 05:44:18.951] start-signalling-1           <DE0005I> Started bundle 'org.eclipse.gemini.blueprint.extender' version '2.0.0.M02'. 
[2015-06-08 05:44:18.951] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.gemini.blueprint.io' version '2.0.0.M02'. 
[2015-06-08 05:44:18.953] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.gemini.blueprint.io' version '2.0.0.M02'. 
[2015-06-08 05:44:18.955] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.virgo.kernel.agent.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:18.956] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.virgo.kernel.agent.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:18.957] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.virgo.kernel.deployer.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:18.961] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.equinox.ds' version '1.4.0.v20120112-1400'. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:19.064] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.equinox.ds' version '1.4.0.v20120112-1400'. 
[2015-06-08 05:44:19.066] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.equinox.util' version '1.0.300.v20111010-1614'. 
[2015-06-08 05:44:19.081] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.virgo.kernel.deployer.dm' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:19.085] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.equinox.util' version '1.0.300.v20111010-1614'. 
[2015-06-08 05:44:19.088] system-artifacts             <DE0004I> Starting configuration 'osgi.console' version '0.0.0'. 
[2015-06-08 05:44:19.959] system-artifacts             <DE0005I> Started configuration 'osgi.console' version '0.0.0'. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:20.156] system-artifacts             <DE0005I> Started plan 'org.eclipse.virgo.kernel.userregion.blueprint' version '3.7.0'. 
[2015-06-08 05:44:20.666] system-artifacts             <DE0000I> Installing plan 'org.eclipse.virgo.management' version '3.7.0'. 
[2015-06-08 05:44:20.706] system-artifacts             <DE0000I> Installing bundle 'osgi.enterprise' version '4.2.0.v201108120515'. 
[2015-06-08 05:44:20.896] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.gemini.management' version '1.0.5.RELEASE'. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:21.286] system-artifacts             <DE0000I> Installing bundle 'org.eclipse.virgo.management.fragment' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:21.387] system-artifacts             <DE0001I> Installed bundle 'osgi.enterprise' version '4.2.0.v201108120515'. 
[2015-06-08 05:44:21.388] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.gemini.management' version '1.0.5.RELEASE'. 
[2015-06-08 05:44:21.390] system-artifacts             <DE0001I> Installed bundle 'org.eclipse.virgo.management.fragment' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:21.391] system-artifacts             <DE0001I> Installed plan 'org.eclipse.virgo.management' version '3.7.0'. 
[2015-06-08 05:44:21.404] system-artifacts             <DE0004I> Starting plan 'org.eclipse.virgo.management' version '3.7.0'. 
[2015-06-08 05:44:21.406] system-artifacts             <DE0004I> Starting bundle 'osgi.enterprise' version '4.2.0.v201108120515'. 
[2015-06-08 05:44:21.409] start-signalling-2           <DE0005I> Started bundle 'osgi.enterprise' version '4.2.0.v201108120515'. 
[2015-06-08 05:44:21.410] system-artifacts             <DE0004I> Starting bundle 'org.eclipse.gemini.management' version '1.0.5.RELEASE'. 
[2015-06-08 05:44:21.421] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.gemini.management' version '1.0.5.RELEASE'. 
[2015-06-08 05:44:21.422] system-artifacts             <DE0005I> Started bundle 'org.eclipse.virgo.management.fragment' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:21.423] system-artifacts             <DE0005I> Started plan 'org.eclipse.virgo.management' version '3.7.0'. 
[2015-06-08 05:44:21.427] sync Event Dispatcher Thread <UR0001I> User region ready. 
[2015-06-08 05:44:21.430] startup-readiness            <KE0007I> Virgo ready. Started for 41.377s. 
Current kernel status: 'STARTED'
[2015-06-08 05:44:22.431] fs-watcher                   <HD0001I> Hot deployer processing 'INITIAL' event for file 'org.eclipse.virgo.management.console_3.7.0.D-20150608092334.jar'. 
[2015-06-08 05:44:22.565] fs-watcher                   <DE0000I> Installing bundle 'org.eclipse.virgo.management.console' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:22.621] fs-watcher                   <DE0001I> Installed bundle 'org.eclipse.virgo.management.console' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:22.627] fs-watcher                   <DE0004I> Starting bundle 'org.eclipse.virgo.management.console' version '3.7.0.D-20150608092334'. 
[2015-06-08 05:44:22.727] start-signalling-2           <DE0005I> Started bundle 'org.eclipse.virgo.management.console' version '3.7.0.D-20150608092334'. 
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Current kernel status: 'STARTED'
Port not available. Waiting for a few seconds.
Port still not available. Trying to shutdown running Virgo.
Port still not available. Giving up.
Current kernel status: 'STARTED'
[2015-06-08 05:44:50.040] System Bundle Shutdown       <KE0010I> Shutdown initiated. 

Standard Error

Jun 08, 2015 5:44:54 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:54 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:44:55 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:55 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:44:56 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:56 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:44:57 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:57 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:44:58 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:58 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:44:59 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:44:59 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:45:00 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:45:00 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:45:01 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:45:01 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:45:02 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:45:02 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:45:03 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:45:03 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping
Jun 08, 2015 5:45:04 AM ClientCommunicatorAdmin Checker-run
WARNING: Failed to check connection: java.net.ConnectException: Connection refused
Jun 08, 2015 5:45:04 AM ClientCommunicatorAdmin Checker-run
WARNING: stopping