You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/01/25 22:38:03 UTC
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk-11.0.6) - Build # 550 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/550/
Java: 64bit/jdk-11.0.6 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.lucene.spatial.vector.TestPointVectorStrategy.testCitiesIntersectsBBox
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([DD3778C5241380D5]:0)
FAILED: junit.framework.TestSuite.org.apache.lucene.spatial.vector.TestPointVectorStrategy
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([DD3778C5241380D5]:0)
Build Log:
[...truncated 11258 lines...]
[junit4] Suite: org.apache.lucene.spatial.vector.TestPointVectorStrategy
[junit4] 2> gen 25, 2020 6:35:51 PM com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
[junit4] 2> AVVERTENZA: Suite execution timed out: org.apache.lucene.spatial.vector.TestPointVectorStrategy
[junit4] 2> 1) Thread[id=11, name=JUnit4-serializer-daemon, state=TIMED_WAITING, group=main]
[junit4] 2> at java.base@11.0.6/java.lang.Thread.sleep(Native Method)
[junit4] 2> at app//com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:50)
[junit4] 2> 2) Thread[id=1, name=main, state=WAITING, group=main]
[junit4] 2> at java.base@11.0.6/java.lang.Object.wait(Native Method)
[junit4] 2> at java.base@11.0.6/java.lang.Thread.join(Thread.java:1305)
[junit4] 2> at java.base@11.0.6/java.lang.Thread.join(Thread.java:1379)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:639)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:496)
[junit4] 2> at app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:269)
[junit4] 2> at app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:394)
[junit4] 2> at app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13)
[junit4] 2> 3) Thread[id=13, name=SUITE-TestPointVectorStrategy-seed#[DD3778C5241380D5], state=RUNNABLE, group=TGRP-TestPointVectorStrategy]
[junit4] 2> at java.base/java.lang.Thread.getStackTrace(Thread.java:1606)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:696)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:693)
[junit4] 2> at java.base/java.security.AccessController.doPrivileged(Native Method)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getStackTrace(ThreadLeakControl.java:693)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:709)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:689)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.access$1000(ThreadLeakControl.java:65)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:415)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:708)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:138)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:629)
[junit4] 2> 4) Thread[id=14, name=TEST-TestPointVectorStrategy.testCitiesIntersectsBBox-seed#[DD3778C5241380D5], state=RUNNABLE, group=TGRP-TestPointVectorStrategy]
[junit4] 2> at java.base@11.0.6/jdk.internal.math.FloatingDecimal$BinaryToASCIIBuffer.estimateDecExp(FloatingDecimal.java:828)
[junit4] 2> at java.base@11.0.6/jdk.internal.math.FloatingDecimal$BinaryToASCIIBuffer.dtoa(FloatingDecimal.java:515)
[junit4] 2> at java.base@11.0.6/jdk.internal.math.FloatingDecimal.getBinaryToASCIIConverter(FloatingDecimal.java:1785)
[junit4] 2> at java.base@11.0.6/jdk.internal.math.FloatingDecimal.getBinaryToASCIIConverter(FloatingDecimal.java:1738)
[junit4] 2> at java.base@11.0.6/jdk.internal.math.FloatingDecimal.appendTo(FloatingDecimal.java:89)
[junit4] 2> at java.base@11.0.6/java.lang.AbstractStringBuilder.append(AbstractStringBuilder.java:840)
[junit4] 2> at java.base@11.0.6/java.lang.StringBuilder.append(StringBuilder.java:266)
[junit4] 2> at app//org.locationtech.spatial4j.shape.impl.PointImpl.toString(PointImpl.java:89)
[junit4] 2> at app//org.apache.lucene.spatial.StrategyTestCase.getDocuments(StrategyTestCase.java:101)
[junit4] 2> at app//org.apache.lucene.spatial.StrategyTestCase.getDocuments(StrategyTestCase.java:84)
[junit4] 2> at app//org.apache.lucene.spatial.StrategyTestCase.getAddAndVerifyIndexedDocuments(StrategyTestCase.java:78)
[junit4] 2> at app//org.apache.lucene.spatial.vector.TestPointVectorStrategy.testCitiesIntersectsBBox(TestPointVectorStrategy.java:67)
[junit4] 2> at java.base@11.0.6/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at java.base@11.0.6/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at java.base@11.0.6/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.base@11.0.6/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.base@11.0.6/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPointVectorStrategy -Dtests.method=testCitiesIntersectsBBox -Dtests.seed=DD3778C5241380D5 -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Mendoza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 1.57s J4 | TestPointVectorStrategy.testCitiesIntersectsBBox <<<
[junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached.
[junit4] > at __randomizedtesting.SeedInfo.seed([DD3778C5241380D5]:0)
[junit4] 2> gen 25, 2020 6:35:52 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> AVVERTENZA: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> gen 25, 2020 6:35:55 PM org.apache.lucene.spatial.StrategyTestCase executeQueries
[junit4] 2> INFORMAZIONI: testing queried for strategy PointVectorStrategy field:TestPointVectorStrategy ctx=SpatialContext.GEO
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@c6df29a), locale=it, timezone=America/Mendoza
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 11.0.6 (64-bit)/cpus=6,threads=1,free=132664832,total=201326592
[junit4] 2> NOTE: All tests run in this JVM: [TestPointVectorStrategy]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPointVectorStrategy -Dtests.seed=DD3778C5241380D5 -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Mendoza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J4 | TestPointVectorStrategy (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([DD3778C5241380D5]:0)
[junit4] Completed [3/25 (1!)] on J4 in 8.75s, 2 tests, 2 errors <<< FAILURES!
[...truncated 50001 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/550/consoleText
[repro] Revision: dbe38b97f5b977989901a05f8238631d92a255a9
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] Repro line: ant test -Dtestcase=TestPointVectorStrategy -Dtests.method=testCitiesIntersectsBBox -Dtests.seed=DD3778C5241380D5 -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Mendoza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] Repro line: ant test -Dtestcase=TestPointVectorStrategy -Dtests.seed=DD3778C5241380D5 -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Mendoza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] lucene/spatial-extras
[repro] TestPointVectorStrategy
[repro] ant compile-test
[...truncated 527 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestPointVectorStrategy" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=DD3778C5241380D5 -Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/Mendoza -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 96 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.lucene.spatial.vector.TestPointVectorStrategy
[repro] Exiting with code 0
[...truncated 75 lines...]
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk1.8.0) - Build # 551 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/551/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.cloud.ConnectionManagerTest.testReconnectWhenZkDisappeared
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([F8B18093BF0307E9:59C0F0FCD63F1124]:0)
at org.junit.Assert.fail(Assert.java:86)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.junit.Assert.assertTrue(Assert.java:52)
at org.apache.solr.cloud.ConnectionManagerTest.testReconnectWhenZkDisappeared(ConnectionManagerTest.java:135)
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:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13599 lines...]
[junit4] Suite: org.apache.solr.cloud.ConnectionManagerTest
[junit4] 2> 160105 INFO (SUITE-ConnectionManagerTest-seed#[F8B18093BF0307E9]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J3/temp/solr.cloud.ConnectionManagerTest_F8B18093BF0307E9-001/data-dir-7-001
[junit4] 2> 160105 WARN (SUITE-ConnectionManagerTest-seed#[F8B18093BF0307E9]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21
[junit4] 2> 160105 INFO (SUITE-ConnectionManagerTest-seed#[F8B18093BF0307E9]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 160115 INFO (SUITE-ConnectionManagerTest-seed#[F8B18093BF0307E9]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 160115 INFO (SUITE-ConnectionManagerTest-seed#[F8B18093BF0307E9]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 160235 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testReconnectWhenZkDisappeared
[junit4] 2> 160236 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 160239 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 160239 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 160374 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer start zk server on port:52977
[junit4] 2> 160375 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:52977
[junit4] 2> 160375 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52977
[junit4] 2> 160375 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52977
[junit4] 2> 160397 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160460 INFO (zkConnectionManagerCallback-441-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160463 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160537 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160566 INFO (zkConnectionManagerCallback-443-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160567 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160590 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160634 INFO (zkConnectionManagerCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160635 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160635 WARN (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c5207d5 name: ZooKeeperConnection Watcher:127.0.0.1:52977/solr got event WatchedEvent state:Expired type:None path: path: type: None
[junit4] 2> 160637 WARN (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper...
[junit4] 2> 160641 ERROR (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager :java.io.IOException: Testing
[junit4] 2> at org.apache.solr.cloud.ConnectionManagerTest$MockZkClientConnectionStrategy.reconnect(ConnectionManagerTest.java:157)
[junit4] 2> at org.apache.solr.common.cloud.ConnectionManager.process(ConnectionManager.java:150)
[junit4] 2> at org.apache.solr.cloud.ConnectionManagerTest.testReconnectWhenZkDisappeared(ConnectionManagerTest.java:133)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 160641 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Could not connect due to error, sleeping for 1s and trying again
[junit4] 2> 162869 WARN (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]-SendThread(127.0.0.1:52977)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 2235ms for sessionid 0x1000b38ee610002
[junit4] 2> 162869 WARN (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one...
[junit4] 2> 162899 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 162906 WARN (NIOWorkerThread-12) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1000b38ee610002, likely client has closed socket
[junit4] 2> 162922 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]-EventThread) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162922 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 162991 WARN (zkConnectionManagerCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c5207d5 name: ZooKeeperConnection Watcher:127.0.0.1:52977/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None
[junit4] 2> 162991 WARN (zkConnectionManagerCallback-445-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 163089 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to ZooKeeper
[junit4] 2> 163089 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager zkClient Connected:false
[junit4] 2> 163201 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 163507 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52977
[junit4] 2> 163507 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52977
[junit4] 2> 163507 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52977
[junit4] 2> 163510 INFO (TEST-ConnectionManagerTest.testReconnectWhenZkDisappeared-seed#[F8B18093BF0307E9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testReconnectWhenZkDisappeared
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ConnectionManagerTest -Dtests.method=testReconnectWhenZkDisappeared -Dtests.seed=F8B18093BF0307E9 -Dtests.slow=true -Dtests.locale=zh-TW -Dtests.timezone=America/Dawson -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 3.40s J3 | ConnectionManagerTest.testReconnectWhenZkDisappeared <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([F8B18093BF0307E9:59C0F0FCD63F1124]:0)
[junit4] > at org.apache.solr.cloud.ConnectionManagerTest.testReconnectWhenZkDisappeared(ConnectionManagerTest.java:135)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 163535 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLikelyExpired
[junit4] 2> 163535 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 163536 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 163536 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 163643 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer start zk server on port:52985
[junit4] 2> 163643 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:52985
[junit4] 2> 163643 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52985
[junit4] 2> 163643 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52985
[junit4] 2> 163656 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 163667 INFO (zkConnectionManagerCallback-447-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163670 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 163689 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 163695 INFO (zkConnectionManagerCallback-449-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163695 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 163700 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 163705 INFO (zkConnectionManagerCallback-451-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163705 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 163705 WARN (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44ffc73c name: ZooKeeperConnection Watcher:127.0.0.1:52985/solr got event WatchedEvent state:Disconnected type:None path: path: type: None
[junit4] 2> 163705 WARN (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 168209 WARN (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44ffc73c name: ZooKeeperConnection Watcher:127.0.0.1:52985/solr got event WatchedEvent state:Disconnected type:None path: path: type: None
[junit4] 2> 168209 WARN (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected
[junit4] 2> 168209 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 168311 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 168529 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52985
[junit4] 2> 168529 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52985
[junit4] 2> 168529 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52985
[junit4] 2> 168530 INFO (TEST-ConnectionManagerTest.testLikelyExpired-seed#[F8B18093BF0307E9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testLikelyExpired
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J3/temp/solr.cloud.ConnectionManagerTest_F8B18093BF0307E9-001
[junit4] 2> Jan 26, 2020 3:05:59 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {}, docValues:{}, maxPointsInLeafNode=160, maxMBSortInHeap=5.476862022230631, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@175ee0e9), locale=zh-TW, timezone=America/Dawson
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/Oracle Corporation 1.8.0_201 (64-bit)/cpus=6,threads=1,free=129676880,total=343408640
[junit4] 2> NOTE: All tests run in this JVM: [ShardRoutingCustomTest, TestShardHandlerFactory, OverseerRolesTest, BasicAuthIntegrationTest, TestBinaryResponseWriter, TestUpdate, MoveReplicaHDFSTest, ConnectionManagerTest]
[junit4] Completed [34/897 (1!)] on J3 in 9.31s, 3 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 55545 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/551/consoleText
[repro] Revision: dbe38b97f5b977989901a05f8238631d92a255a9
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[repro] Repro line: ant test -Dtestcase=ConnectionManagerTest -Dtests.method=testReconnectWhenZkDisappeared -Dtests.seed=F8B18093BF0307E9 -Dtests.slow=true -Dtests.locale=zh-TW -Dtests.timezone=America/Dawson -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] ConnectionManagerTest
[repro] ant compile-test
[...truncated 3624 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.ConnectionManagerTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=F8B18093BF0307E9 -Dtests.slow=true -Dtests.locale=zh-TW -Dtests.timezone=America/Dawson -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 81 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.ConnectionManagerTest
[repro] Exiting with code 0
[...truncated 73 lines...]