[GEODE-6282] CI Failure: WindowsGfshDistributedTestOpenJDK11.connectWithSSL

• Type: Bug
• Status: Resolved
• Priority: Major
• Resolution: Won't Fix
• Assignee: Unassigned
• Reporter: Ryan McMahon
• Created: 15/Jan/19 23:27
• Updated: 17/Jan/19 17:59
• Resolved: 17/Jan/19 17:59

Description

 

org.apache.geode.management.internal.cli.commands.ConnectCommandWithSSLTest > connectWithSSL FAILED
 java.lang.AssertionError: Suspicious strings were written to the log during this run.
 Fix the strings or use IgnoredException.addIgnoredException to ignore.
 -----------------------------------------------------------------------
 Found suspect string in log4j at line 1233
[error 2019/01/15 20:17:38.966 GMT <RMI TCP Connection(2)-10.0.0.31> tid=63] Jmx manager could not be started because HTTP service failed to start
 org.apache.geode.management.ManagementException: HTTP service failed to start
 at org.apache.geode.management.internal.ManagementAgent.startHttpService(ManagementAgent.java:349)
 at org.apache.geode.management.internal.ManagementAgent.startAgent(ManagementAgent.java:159)
 at org.apache.geode.management.internal.SystemManagementService.startManager(SystemManagementService.java:432)
 at org.apache.geode.management.internal.beans.ManagementAdapter.handleCacheCreation(ManagementAdapter.java:173)
 at org.apache.geode.management.internal.beans.ManagementListener.handleEvent(ManagementListener.java:115)
 at org.apache.geode.distributed.internal.InternalDistributedSystem.notifyResourceEventListeners(InternalDistributedSystem.java:2234)
 at org.apache.geode.distributed.internal.InternalDistributedSystem.handleResourceEvent(InternalDistributedSystem.java:606)
 at org.apache.geode.internal.cache.GemFireCacheImpl.initialize(GemFireCacheImpl.java:1214)
 at org.apache.geode.internal.cache.GemFireCacheImpl.basicCreate(GemFireCacheImpl.java:799)
 at org.apache.geode.internal.cache.GemFireCacheImpl.create(GemFireCacheImpl.java:785)
 at org.apache.geode.cache.CacheFactory.create(CacheFactory.java:176)
 at org.apache.geode.cache.CacheFactory.create(CacheFactory.java:223)
 at org.apache.geode.distributed.internal.InternalLocator.startCache(InternalLocator.java:657)
 at org.apache.geode.distributed.internal.InternalLocator.startDistributedSystem(InternalLocator.java:644)
 at org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:330)
 at org.apache.geode.distributed.Locator.startLocator(Locator.java:252)
 at org.apache.geode.distributed.Locator.startLocatorAndDS(Locator.java:139)
 at org.apache.geode.test.junit.rules.LocatorStarterRule.startLocator(LocatorStarterRule.java:85)
 at org.apache.geode.test.junit.rules.LocatorStarterRule.before(LocatorStarterRule.java:66)
 at org.apache.geode.test.dunit.rules.ClusterStartupRule.lambda$startLocatorVM$22d9b8a8$1(ClusterStartupRule.java:208)
 at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
 at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 at java.base/java.lang.reflect.Method.invoke(Method.java:566)
 at org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123)
 at org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:69)
 at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
 at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
 at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 at java.base/java.lang.reflect.Method.invoke(Method.java:566)
 at java.rmi/sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:359)
 at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:200)
 at java.rmi/sun.rmi.transport.Transport$1.run(Transport.java:197)
 at java.base/java.security.AccessController.doPrivileged(Native Method)
 at java.rmi/sun.rmi.transport.Transport.serviceCall(Transport.java:196)
 at java.rmi/sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:562)
 at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:796)
 at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:677)
 at java.base/java.security.AccessController.doPrivileged(Native Method)
 at java.rmi/sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:676)
 at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
 at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
 at java.base/java.lang.Thread.run(Thread.java:834)
 Caused by: java.net.BindException: Address already in use: bind
 at java.base/sun.nio.ch.Net.bind0(Native Method)
 at java.base/sun.nio.ch.Net.bind(Net.java:461)
 at java.base/sun.nio.ch.Net.bind(Net.java:453)
 at java.base/sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:227)
 at java.base/sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:80)
 at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:339)
 at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:307)
 at org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
 at org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:235)
 at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
 at org.eclipse.jetty.server.Server.doStart(Server.java:395)
 at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
 at org.apache.geode.management.internal.JettyHelper.startJetty(JettyHelper.java:165)
 at org.apache.geode.management.internal.ManagementAgent.startHttpService(ManagementAgent.java:321)
 ... 42 more
-----------------------------------------------------------------------
 Found suspect string in log4j at line 1295
[error 2019/01/15 20:17:38.982 GMT <RMI TCP Connection(2)-10.0.0.31> tid=63] org.apache.geode.management.ManagementException: HTTP service failed to start

[https://concourse.apachegeode-ci.info/teams/main/pipelines/apache-develop-main/jobs/WindowsGfshDistributedTestOpenJDK11/builds/224

]

 

=-=-=-=-=-=-=-=-=-=-=-=-=-=-= Test Results URI =-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
http://files.apachegeode-ci.info/builds/apache-develop-main/1.9.0-SNAPSHOT.0339/test-results/distributedTest/1547589774/
=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=-=
Test report artifacts from this job are available at:
http://files.apachegeode-ci.info/builds/apache-develop-main/1.9.0-SNAPSHOT.0339/test-artifacts/1547589774/windows-gfshdistributedtest-OpenJDK11-1.9.0-SNAPSHOT.0339.tgz

This also fails in the same way in the connectWithClusterAndJmxSSL test.

 

Issue Links

• is related to: GEODE-6268 initializeUniquePortRange_willReturnUniquePortsForUniqueRanges seems flaky on Windows