[
https://issues.apache.org/jira/browse/GEODE-5590?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16583052#comment-16583052
]
Kenneth Howe commented on GEODE-5590:
-------------------------------------
Similar failures found in recent AcceptanceTest CI failures for
{{[DeployWithLargeJarTest|http://files.apachegeode-ci.info/builds/1.8.0-build.1288/test-results/acceptanceTest/1534356362/classes/org.apache.geode.management.internal.cli.commands.DeployWithLargeJarTest.html]}}
and
{{[StopServerAcceptanceTest|http://files.apachegeode-ci.info/builds/1.8.0-build.1288/test-results/acceptanceTest/1534356362/classes/org.apache.geode.management.internal.cli.commands.StopServerAcceptanceTest.html]}}.
Examination of the console log for the failures shows that when starting the
cluster the default server port (40404) is in use.
{code:java}
[INFO 01:35:12.899 UTC] (3865e9d1bca85f4a): (2) Executing - stop server
--name=server
[INFO 01:35:12.899 UTC] (3865e9d1bca85f4a):
[INFO 01:35:14.553 UTC] (3865e9d1bca85f4a): ...
[INFO 01:35:16.362 UTC] (teardown-stop-locator):
[INFO 01:35:16.363 UTC] (teardown-stop-locator): (1) Executing - stop locator
--dir="/tmp/junit6893862426879423309/cluster-setup/locator"
[INFO 01:35:16.363 UTC] (teardown-stop-locator):
[INFO 01:35:18.540 UTC] (teardown-stop-locator): ..
[INFO 01:35:20.183 UTC] (cluster-setup):
[INFO 01:35:20.183 UTC] (cluster-setup): (1) Executing - start locator
--name=locator
--security-properties-file=/tmp/junit1230333947702514837/security.properties
[INFO 01:35:20.183 UTC] (cluster-setup):
[INFO 01:35:25.963 UTC] (cluster-setup): .....
[INFO 01:35:33.189 UTC] (cluster-setup): Locator in
/tmp/junit1230333947702514837/cluster-setup/locator on
build-develop-acceptancetest-319.c.apachegeode-ci.internal[10334] as locator is
currently online.
[INFO 01:35:33.189 UTC] (cluster-setup): Process ID: 6533
[INFO 01:35:33.189 UTC] (cluster-setup): Uptime: 5 seconds
[INFO 01:35:33.189 UTC] (cluster-setup): Geode Version: 1.8.0-SNAPSHOT
[INFO 01:35:33.189 UTC] (cluster-setup): Java Version: 1.8.0_181
[INFO 01:35:33.189 UTC] (cluster-setup): Log File:
/tmp/junit1230333947702514837/cluster-setup/locator/locator.log
[INFO 01:35:33.190 UTC] (cluster-setup): JVM Arguments:
-DgemfireSecurityPropertyFile=/tmp/junit1230333947702514837/security.properties
-Dgemfire.enable-cluster-configuration=true
-Dgemfire.load-cluster-configuration-from-dir=false
-Dgemfire.launcher.registerSignalHandlers=true -Djava.awt.headless=true
-Dsun.rmi.dgc.server.gcInterval=9223372036854775806
[INFO 01:35:33.190 UTC] (cluster-setup): Class-Path:
/home/geode/geode/geode-assembly/build/install/apache-geode/lib/geode-core-1.8.0-SNAPSHOT.jar:/home/geode/geode/geode-assembly/build/install/apache-geode/lib/geode-dependencies.jar
[INFO 01:35:33.190 UTC] (cluster-setup):
[INFO 01:35:33.190 UTC] (cluster-setup): Successfully connected to: JMX
Manager [host=build-develop-acceptancetest-319.c.apachegeode-ci.internal,
port=1099]
[INFO 01:35:33.190 UTC] (cluster-setup):
[INFO 01:35:33.190 UTC] (cluster-setup): Cluster configuration service is up
and running.
[INFO 01:35:33.190 UTC] (cluster-setup):
[INFO 01:35:33.190 UTC] (cluster-setup):
[INFO 01:35:33.190 UTC] (cluster-setup): (2) Executing - start server
--name=server
--security-properties-file=/tmp/junit1230333947702514837/security.properties
[INFO 01:35:33.191 UTC] (cluster-setup):
[ERROR 01:35:35.320 UTC] (cluster-setup): The Cache Server process terminated
unexpectedly with exit status 1. Please refer to the log file in
/tmp/junit1230333947702514837/cluster-setup/server for full details.
[ERROR 01:35:35.321 UTC] (cluster-setup):
[ERROR 01:35:35.321 UTC] (cluster-setup): Exception in thread "main"
java.lang.RuntimeException: An IO error occurred while starting a Server in
/tmp/junit1230333947702514837/cluster-setup/server on
build-develop-acceptancetest-319.c.apachegeode-ci.internal[40404]: Network is
unreachable; port (40404) is not available on localhost.
[ERROR 01:35:35.321 UTC] (cluster-setup):
[ERROR 01:35:35.321 UTC] (cluster-setup): at
org.apache.geode.distributed.ServerLauncher.start(ServerLauncher.java:816)
[ERROR 01:35:35.322 UTC] (cluster-setup):
[ERROR 01:35:35.322 UTC] (cluster-setup): at
org.apache.geode.distributed.ServerLauncher.run(ServerLauncher.java:704)
[ERROR 01:35:35.322 UTC] (cluster-setup):
[ERROR 01:35:35.322 UTC] (cluster-setup): at
org.apache.geode.distributed.ServerLauncher.main(ServerLauncher.java:224)
[ERROR 01:35:35.322 UTC] (cluster-setup):
[ERROR 01:35:35.322 UTC] (cluster-setup): Caused by: java.net.BindException:
Network is unreachable; port (40404) is not available on localhost.
[ERROR 01:35:35.322 UTC] (cluster-setup):
[ERROR 01:35:35.325 UTC] (cluster-setup): at
org.apache.geode.distributed.AbstractLauncher.assertPortAvailable(AbstractLauncher.java:129)
[ERROR 01:35:35.325 UTC] (cluster-setup):
[ERROR 01:35:35.325 UTC] (cluster-setup): at
org.apache.geode.distributed.ServerLauncher.start(ServerLauncher.java:761)
[ERROR 01:35:35.325 UTC] (cluster-setup):
[ERROR 01:35:35.325 UTC] (cluster-setup): ... 2 more
[ERROR 01:35:35.325 UTC] (cluster-setup):
{code}
It appears that after shutting down from the previous test, the port has not
been released by the time the subsequent test executes the {{start server}}
command.
The following documentation for ServerSocket may be relevant to this failure:
https://docs.oracle.com/javase/8/docs/api/java/net/ServerSocket.html#getReuseAddress--
> CI Failure: PutCommandWithJsonTest > putWithJsonString Fails intermittently
> ----------------------------------------------------------------------------
>
> Key: GEODE-5590
> URL: https://issues.apache.org/jira/browse/GEODE-5590
> Project: Geode
> Issue Type: Bug
> Reporter: Helena Bales
> Priority: Major
> Labels: swat
>
> {code:java}
> org.apache.geode.management.internal.cli.commands.PutCommandWithJsonTest >
> putWithJsonString FAILED
> org.junit.ComparisonFailure: expected:<[0]> but was:<[1]>
> at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
> at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
> at
> org.apache.geode.test.junit.rules.gfsh.GfshScript.awaitIfNecessary(GfshScript.java:117)
> at
> org.apache.geode.test.junit.rules.gfsh.GfshRule.execute(GfshRule.java:135)
> at
> org.apache.geode.test.junit.rules.gfsh.GfshScript.execute(GfshScript.java:106)
> at
> org.apache.geode.management.internal.cli.commands.PutCommandWithJsonTest.putWithJsonString(PutCommandWithJsonTest.java:55)
> {code}
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
