Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/388/
5 tests failed.
FAILED: org.apache.lucene.document.TestLatLonLineShapeQueries.testRandomBig
Error Message:
Java heap space
Stack Trace:
java.lang.OutOfMemoryError: Java heap space
at
__randomizedtesting.SeedInfo.seed([482F47F22BFAEA7D:CF783A7DBAA396FD]:0)
at org.apache.lucene.store.RAMFile.newBuffer(RAMFile.java:84)
at org.apache.lucene.store.RAMFile.addBuffer(RAMFile.java:57)
at
org.apache.lucene.store.RAMOutputStream.switchCurrentBuffer(RAMOutputStream.java:168)
at
org.apache.lucene.store.RAMOutputStream.writeBytes(RAMOutputStream.java:154)
at
org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
at
org.apache.lucene.util.bkd.OfflinePointReader.split(OfflinePointReader.java:215)
at org.apache.lucene.util.bkd.BKDWriter.build(BKDWriter.java:1846)
at org.apache.lucene.util.bkd.BKDWriter.finish(BKDWriter.java:1025)
at
org.apache.lucene.index.RandomCodec$1$1.writeField(RandomCodec.java:142)
at
org.apache.lucene.codecs.PointsWriter.mergeOneField(PointsWriter.java:62)
at org.apache.lucene.codecs.PointsWriter.merge(PointsWriter.java:191)
at
org.apache.lucene.codecs.lucene60.Lucene60PointsWriter.merge(Lucene60PointsWriter.java:145)
at
org.apache.lucene.codecs.asserting.AssertingPointsFormat$AssertingPointsWriter.merge(AssertingPointsFormat.java:142)
at
org.apache.lucene.index.SegmentMerger.mergePoints(SegmentMerger.java:188)
at org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:137)
at
org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4476)
at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4071)
at
org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
at org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2171)
at org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2004)
at org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:1955)
at
org.apache.lucene.document.BaseLatLonShapeTestCase.indexRandomShapes(BaseLatLonShapeTestCase.java:267)
at
org.apache.lucene.document.BaseLatLonShapeTestCase.verify(BaseLatLonShapeTestCase.java:231)
at
org.apache.lucene.document.BaseLatLonShapeTestCase.doTestRandom(BaseLatLonShapeTestCase.java:212)
at
org.apache.lucene.document.BaseLatLonShapeTestCase.testRandomBig(BaseLatLonShapeTestCase.java:188)
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:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
FAILED: org.apache.solr.cloud.RestartWhileUpdatingTest.test
Error Message:
There are still nodes recoverying - waited for 320 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 320
seconds
at
__randomizedtesting.SeedInfo.seed([924B239A0D0C5F23:1A1F1C40A3F032DB]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:185)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:920)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1477)
at
org.apache.solr.cloud.RestartWhileUpdatingTest.test(RestartWhileUpdatingTest.java:145)
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:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1010)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:985)
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:944)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
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)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.RestartWhileUpdatingTest
Error Message:
7 threads leaked from SUITE scope at
org.apache.solr.cloud.RestartWhileUpdatingTest: 1) Thread[id=18968,
name=searcherExecutor-7256-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=19090,
name=searcherExecutor-7298-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 3) Thread[id=19169,
name=searcherExecutor-7318-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 4) Thread[id=19047,
name=searcherExecutor-7284-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 5) Thread[id=19010,
name=searcherExecutor-7270-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 6) Thread[id=19204,
name=searcherExecutor-7332-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 7) Thread[id=19239,
name=searcherExecutor-7346-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 7 threads leaked from SUITE
scope at org.apache.solr.cloud.RestartWhileUpdatingTest:
1) Thread[id=18968, name=searcherExecutor-7256-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=19090, name=searcherExecutor-7298-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
3) Thread[id=19169, name=searcherExecutor-7318-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
4) Thread[id=19047, name=searcherExecutor-7284-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
5) Thread[id=19010, name=searcherExecutor-7270-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
6) Thread[id=19204, name=searcherExecutor-7332-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
7) Thread[id=19239, name=searcherExecutor-7346-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([924B239A0D0C5F23]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.RestartWhileUpdatingTest
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=18968, name=searcherExecutor-7256-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=19090,
name=searcherExecutor-7298-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 3) Thread[id=19169,
name=searcherExecutor-7318-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 4) Thread[id=19047,
name=searcherExecutor-7284-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 5) Thread[id=19010,
name=searcherExecutor-7270-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 6) Thread[id=19204,
name=searcherExecutor-7332-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 7) Thread[id=19239,
name=searcherExecutor-7346-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=18968, name=searcherExecutor-7256-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=19090, name=searcherExecutor-7298-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
3) Thread[id=19169, name=searcherExecutor-7318-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
4) Thread[id=19047, name=searcherExecutor-7284-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
5) Thread[id=19010, name=searcherExecutor-7270-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
6) Thread[id=19204, name=searcherExecutor-7332-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
7) Thread[id=19239, name=searcherExecutor-7346-thread-1, state=WAITING,
group=TGRP-RestartWhileUpdatingTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([924B239A0D0C5F23]:0)
FAILED:
org.apache.solr.client.solrj.impl.CloudSolrClientTest.testParallelUpdateQTime
Error Message:
Error from server at http://127.0.0.1:39061/solr/collection1_shard2_replica_n2:
Expected mime type application/octet-stream but got text/html. <html> <head>
<meta http-equiv="Content-Type" content="text/html;charset=utf-8"/>
<title>Error 404 Can not find:
/solr/collection1_shard2_replica_n2/update</title> </head> <body><h2>HTTP ERROR
404</h2> <p>Problem accessing /solr/collection1_shard2_replica_n2/update.
Reason: <pre> Can not find:
/solr/collection1_shard2_replica_n2/update</pre></p><hr><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.11.v20180605</a><hr/>
</body> </html>
Stack Trace:
org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Error from
server at http://127.0.0.1:39061/solr/collection1_shard2_replica_n2: Expected
mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=utf-8"/>
<title>Error 404 Can not find:
/solr/collection1_shard2_replica_n2/update</title>
</head>
<body><h2>HTTP ERROR 404</h2>
<p>Problem accessing /solr/collection1_shard2_replica_n2/update. Reason:
<pre> Can not find:
/solr/collection1_shard2_replica_n2/update</pre></p><hr><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.11.v20180605</a><hr/>
</body>
</html>
at
__randomizedtesting.SeedInfo.seed([DC1DE2A20FADEA32:32C5993341D23FA1]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:551)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1016)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.impl.CloudSolrClientTest.testParallelUpdateQTime(CloudSolrClientTest.java:146)
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:1742)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
at
org.junit.rules.ExpectedException$ExpectedExceptionStatement.evaluate(ExpectedException.java:110)
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:944)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
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)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:39061/solr/collection1_shard2_replica_n2:
Expected mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=utf-8"/>
<title>Error 404 Can not find:
/solr/collection1_shard2_replica_n2/update</title>
</head>
<body><h2>HTTP ERROR 404</h2>
<p>Problem accessing /solr/collection1_shard2_replica_n2/update. Reason:
<pre> Can not find:
/solr/collection1_shard2_replica_n2/update</pre></p><hr><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.11.v20180605</a><hr/>
</body>
</html>
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:528)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
... 1 more
Build Log:
[...truncated 10317 lines...]
[junit4] Suite: org.apache.lucene.document.TestLatLonLineShapeQueries
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestLatLonLineShapeQueries -Dtests.method=testRandomBig
-Dtests.seed=482F47F22BFAEA7D -Dtests.multiplier=2 -Dtests.nightly=true
-Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
-Dtests.locale=es -Dtests.timezone=America/Cambridge_Bay -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 445s J2 | TestLatLonLineShapeQueries.testRandomBig <<<
[junit4] > Throwable #1: java.lang.OutOfMemoryError: Java heap space
[junit4] > at
__randomizedtesting.SeedInfo.seed([482F47F22BFAEA7D:CF783A7DBAA396FD]:0)
[junit4] > at
org.apache.lucene.store.RAMFile.newBuffer(RAMFile.java:84)
[junit4] > at
org.apache.lucene.store.RAMFile.addBuffer(RAMFile.java:57)
[junit4] > at
org.apache.lucene.store.RAMOutputStream.switchCurrentBuffer(RAMOutputStream.java:168)
[junit4] > at
org.apache.lucene.store.RAMOutputStream.writeBytes(RAMOutputStream.java:154)
[junit4] > at
org.apache.lucene.store.MockIndexOutputWrapper.writeBytes(MockIndexOutputWrapper.java:141)
[junit4] > at
org.apache.lucene.util.bkd.OfflinePointReader.split(OfflinePointReader.java:215)
[junit4] > at
org.apache.lucene.util.bkd.BKDWriter.build(BKDWriter.java:1846)
[junit4] > at
org.apache.lucene.util.bkd.BKDWriter.finish(BKDWriter.java:1025)
[junit4] > at
org.apache.lucene.index.RandomCodec$1$1.writeField(RandomCodec.java:142)
[junit4] > at
org.apache.lucene.codecs.PointsWriter.mergeOneField(PointsWriter.java:62)
[junit4] > at
org.apache.lucene.codecs.PointsWriter.merge(PointsWriter.java:191)
[junit4] > at
org.apache.lucene.codecs.lucene60.Lucene60PointsWriter.merge(Lucene60PointsWriter.java:145)
[junit4] > at
org.apache.lucene.codecs.asserting.AssertingPointsFormat$AssertingPointsWriter.merge(AssertingPointsFormat.java:142)
[junit4] > at
org.apache.lucene.index.SegmentMerger.mergePoints(SegmentMerger.java:188)
[junit4] > at
org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:137)
[junit4] > at
org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4476)
[junit4] > at
org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4071)
[junit4] > at
org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
[junit4] > at
org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2171)
[junit4] > at
org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2004)
[junit4] > at
org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:1955)
[junit4] > at
org.apache.lucene.document.BaseLatLonShapeTestCase.indexRandomShapes(BaseLatLonShapeTestCase.java:267)
[junit4] > at
org.apache.lucene.document.BaseLatLonShapeTestCase.verify(BaseLatLonShapeTestCase.java:231)
[junit4] > at
org.apache.lucene.document.BaseLatLonShapeTestCase.doTestRandom(BaseLatLonShapeTestCase.java:212)
[junit4] > at
org.apache.lucene.document.BaseLatLonShapeTestCase.testRandomBig(BaseLatLonShapeTestCase.java:188)
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/sandbox/test/J2/temp/lucene.document.TestLatLonLineShapeQueries_482F47F22BFAEA7D-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{id=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{shape=DocValuesFormat(name=Lucene70),
id=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=296,
maxMBSortInHeap=6.936226929976044, sim=RandomSimilarity(queryNorm=true): {},
locale=es, timezone=America/Cambridge_Bay
[junit4] 2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation
1.8.0_191 (64-bit)/cpus=4,threads=1,free=347953624,total=448266240
[junit4] 2> NOTE: All tests run in this JVM: [TestIntervalQuery,
TestLatLonBoundingBoxQueries, TestPayloadSpanUtil, TestLatLonShape,
TestBigIntegerPoint, TestDoubleRangeField, TestHalfFloatPoint,
TestLatLonLineShapeQueries]
[junit4] Completed [21/22 (1!)] on J2 in 1090.79s, 4 tests, 1 error <<<
FAILURES!
[...truncated 1 lines...]
[junit4] JVM J2: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/sandbox/test/temp/junit4-J2-20181126_173702_3872924308435227371441.sysout
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/heapdumps/java_pid26687.hprof
...
[junit4] Heap dump file created [531658546 bytes in 0.835 secs]
[junit4] <<< JVM J2: EOF ----
[...truncated 4519 lines...]
[junit4] Suite: org.apache.solr.cloud.RestartWhileUpdatingTest
[junit4] 2> 2966370 INFO
(SUITE-RestartWhileUpdatingTest-seed#[924B239A0D0C5F23]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/init-core-data-001
[junit4] 2> 2966371 INFO
(SUITE-RestartWhileUpdatingTest-seed#[924B239A0D0C5F23]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2966373 INFO
(SUITE-RestartWhileUpdatingTest-seed#[924B239A0D0C5F23]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2966375 INFO
(SUITE-RestartWhileUpdatingTest-seed#[924B239A0D0C5F23]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /wc/cd
[junit4] 2> 2966377 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2966377 INFO (Thread-3097) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2966377 INFO (Thread-3097) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2966380 ERROR (Thread-3097) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 2966477 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ZkTestServer start zk server on port:33637
[junit4] 2> 2966479 INFO (zkConnectionManagerCallback-5694-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966484 INFO (zkConnectionManagerCallback-5696-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966491 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2966493 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 2966495 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2966496 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2966498 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2966499 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2966501 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2966502 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2966504 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2966505 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2966507 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2966509 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 2966681 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 2966682 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2966682 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2966682 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2966685 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2f141444{/wc/cd,null,AVAILABLE}
[junit4] 2> 2966687 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2fe1eba{HTTP/1.1,[http/1.1]}{127.0.0.1:34655}
[junit4] 2> 2966687 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.Server Started @2966740ms
[junit4] 2> 2966687 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/tempDir-001/control/data,
replicaType=NRT, hostContext=/wc/cd, hostPort=34655,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/control-001/cores}
[junit4] 2> 2966687 ERROR
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2966688 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2966688 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.7.0
[junit4] 2> 2966688 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2966688 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2966688 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-11-26T19:30:52.960Z
[junit4] 2> 2966691 INFO (zkConnectionManagerCallback-5698-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966692 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2966692 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/control-001/solr.xml
[junit4] 2> 2966697 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2966697 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2966699 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2966813 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33637/solr
[junit4] 2> 2966815 INFO (zkConnectionManagerCallback-5702-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966817 INFO (zkConnectionManagerCallback-5704-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966950 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:34655_wc%2Fcd
[junit4] 2> 2966951 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.Overseer Overseer
(id=72345653269233668-127.0.0.1:34655_wc%2Fcd-n_0000000000) starting
[junit4] 2> 2966962 INFO (zkConnectionManagerCallback-5711-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2966964 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.s.i.ZkClientClusterStateProvider
Cluster at 127.0.0.1:33637/solr ready
[junit4] 2> 2966967 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34655_wc%2Fcd
[junit4] 2> 2966968 INFO
(OverseerStateUpdate-72345653269233668-127.0.0.1:34655_wc%2Fcd-n_0000000000)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:34655_wc%2Fcd
[junit4] 2> 2966979 INFO (zkCallback-5710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2966983 INFO
(OverseerStateUpdate-72345653269233668-127.0.0.1:34655_wc%2Fcd-n_0000000000)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2967002 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 2967031 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2967047 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2967047 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2967049 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23])
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/control-001/cores
[junit4] 2> 2967077 INFO (zkConnectionManagerCallback-5717-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2967078 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2967079 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33637/solr ready
[junit4] 2> 2967081 INFO (qtp739036438-18928) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34655_wc%252Fcd&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2967084 INFO
(OverseerThreadFactory-7251-thread-1-processing-n:127.0.0.1:34655_wc%2Fcd)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.a.c.CreateCollectionCmd Create
collection control_collection
[junit4] 2> 2967194 INFO (qtp739036438-18923) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=1
[junit4] 2> 2967203 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
x:control_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2967205 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
x:control_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2968226 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 2968241 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 2968346 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2968365 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from collection control_collection, trusted=true
[junit4] 2> 2968366 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.replica_n1' (registry
'solr.core.control_collection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2968366 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore
at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/control-001/cores/control_collection_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 2968371 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=1.4716796875,
floorSegmentMB=1.68359375, forceMergeDeletesPctAllowed=4.731565365136918,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6124625556705002, deletesPctAllowed=24.861282607972207
[junit4] 2> 2968377 WARN (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 2968446 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2968446 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2968448 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 30000ms;
[junit4] 2> 2968448 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: if uncommitted for 3000ms;
[junit4] 2> 2968450 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=2.08203125,
floorSegmentMB=1.56640625, forceMergeDeletesPctAllowed=13.803340865580154,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.4546552419712263, deletesPctAllowed=36.22001974175663
[junit4] 2> 2968451 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6c354c6[control_collection_shard1_replica_n1] main]
[junit4] 2> 2968452 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2968452 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2968453 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2968455 INFO
(searcherExecutor-7256-thread-1-processing-n:127.0.0.1:34655_wc%2Fcd
x:control_collection_shard1_replica_n1 c:control_collection s:shard1)
[n:127.0.0.1:34655_wc%2Fcd c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore
[control_collection_shard1_replica_n1] Registered new searcher
Searcher@6c354c6[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2968455 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1618226084291018752
[junit4] 2> 2968462 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/control_collection/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 2968466 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2968466 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2968466 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:34655/wc/cd/control_collection_shard1_replica_n1/
[junit4] 2> 2968467 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2968468 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy
http://127.0.0.1:34655/wc/cd/control_collection_shard1_replica_n1/ has no
replicas
[junit4] 2> 2968468 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 2968472 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:34655/wc/cd/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 2968475 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2968477 INFO (qtp739036438-18924) [n:127.0.0.1:34655_wc%2Fcd
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1278
[junit4] 2> 2968480 INFO (qtp739036438-18928) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 2968577 INFO (zkCallback-5703-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 2969087 INFO
(OverseerCollectionConfigSetProcessor-72345653269233668-127.0.0.1:34655_wc%2Fcd-n_0000000000)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2969480 INFO (qtp739036438-18928) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34655_wc%252Fcd&wt=javabin&version=2}
status=0 QTime=2398
[junit4] 2> 2969485 INFO (zkConnectionManagerCallback-5722-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2969486 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2969487 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33637/solr ready
[junit4] 2> 2969487 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 2969488 INFO (qtp739036438-18927) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2969492 INFO
(OverseerThreadFactory-7251-thread-2-processing-n:127.0.0.1:34655_wc%2Fcd)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.a.c.CreateCollectionCmd Create
collection collection1
[junit4] 2> 2969696 WARN
(OverseerThreadFactory-7251-thread-2-processing-n:127.0.0.1:34655_wc%2Fcd)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.a.c.CreateCollectionCmd It is unusual
to create a collection (collection1) without cores.
[junit4] 2> 2969698 INFO (qtp739036438-18927) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 2969698 INFO (qtp739036438-18927) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=1&wt=javabin&version=2}
status=0 QTime=209
[junit4] 2> 2969947 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001
of type NRT
[junit4] 2> 2969949 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_191-b12
[junit4] 2> 2969950 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2969950 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2969950 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2969951 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@234fce51{/wc/cd,null,AVAILABLE}
[junit4] 2> 2969952 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@de3b1a3{HTTP/1.1,[http/1.1]}{127.0.0.1:38395}
[junit4] 2> 2969952 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.Server Started @2970005ms
[junit4] 2> 2969952 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/tempDir-001/jetty1,
replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/wc/cd,
hostPort=38395,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001/cores}
[junit4] 2> 2969953 ERROR
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2969953 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2969953 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.7.0
[junit4] 2> 2969953 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2969953 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2969953 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-11-26T19:30:56.225Z
[junit4] 2> 2969956 INFO (zkConnectionManagerCallback-5724-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2969957 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2969957 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001/solr.xml
[junit4] 2> 2969978 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2969978 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2969980 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2970213 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33637/solr
[junit4] 2> 2970214 INFO (zkConnectionManagerCallback-5728-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2970221 INFO (zkConnectionManagerCallback-5730-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2970232 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2970243 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 2970243 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38395_wc%2Fcd
[junit4] 2> 2970251 INFO (zkCallback-5703-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2970251 INFO (zkCallback-5710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2970251 INFO (zkCallback-5721-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2970252 INFO (zkCallback-5729-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2970292 INFO (zkConnectionManagerCallback-5737-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2970293 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2970295 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33637/solr ready
[junit4] 2> 2970296 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 2970329 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2970349 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2970349 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2970352 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001/cores
[junit4] 2> 2970394 INFO (qtp739036438-18930) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:38395_wc%252Fcd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2970397 INFO
(OverseerCollectionConfigSetProcessor-72345653269233668-127.0.0.1:34655_wc%2Fcd-n_0000000000)
[n:127.0.0.1:34655_wc%2Fcd ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2970407 INFO (qtp739036438-18927) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={wt=javabin&version=2&key=solr.core.control_collection.shard1.replica_n1:INDEX.sizeInBytes}
status=0 QTime=1
[junit4] 2> 2970408 INFO (qtp739036438-18923) [n:127.0.0.1:34655_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 2970411 INFO (qtp298502552-18982) [n:127.0.0.1:38395_wc%2Fcd
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
status=0 QTime=0
[junit4] 2> 2970412 INFO
(OverseerThreadFactory-7251-thread-3-processing-n:127.0.0.1:34655_wc%2Fcd)
[n:127.0.0.1:34655_wc%2Fcd c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:38395_wc%2Fcd for creating new replica of shard
shard1 for collection collection1
[junit4] 2> 2970415 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
x:collection1_shard1_replica_n21] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n21&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2971439 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.7.0
[junit4] 2> 2971454 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.s.IndexSchema
[collection1_shard1_replica_n21] Schema name=test
[junit4] 2> 2971564 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2971582 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica_n21' using configuration from
collection collection1, trusted=true
[junit4] 2> 2971582 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_n21' (registry
'solr.core.collection1.shard1.replica_n21') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3ff57eb5
[junit4] 2> 2971583 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.SolrCore
[[collection1_shard1_replica_n21] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001/cores/collection1_shard1_replica_n21],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-1-001/cores/collection1_shard1_replica_n21/data/]
[junit4] 2> 2971587 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=46, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=1.4716796875,
floorSegmentMB=1.68359375, forceMergeDeletesPctAllowed=4.731565365136918,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6124625556705002, deletesPctAllowed=24.861282607972207
[junit4] 2> 2971597 WARN (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 2971666 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2971666 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2971667 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.u.CommitTracker
Hard AutoCommit: if uncommitted for 30000ms;
[junit4] 2> 2971667 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.u.CommitTracker
Soft AutoCommit: if uncommitted for 3000ms;
[junit4] 2> 2971669 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=2.08203125,
floorSegmentMB=1.56640625, forceMergeDeletesPctAllowed=13.803340865580154,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.4546552419712263, deletesPctAllowed=36.22001974175663
[junit4] 2> 2971670 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7cac6540[collection1_shard1_replica_n21] main]
[junit4] 2> 2971671 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2971672 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2971673 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2971673 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1618226087665336320
[junit4] 2> 2971674 INFO
(searcherExecutor-7270-thread-1-processing-n:127.0.0.1:38395_wc%2Fcd
x:collection1_shard1_replica_n21 c:collection1 s:shard1)
[n:127.0.0.1:38395_wc%2Fcd c:collection1 s:shard1
x:collection1_shard1_replica_n21] o.a.s.c.SolrCore
[collection1_shard1_replica_n21] Registered new searcher
Searcher@7cac6540[collection1_shard1_replica_n21]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2971679 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/collection1/terms/shard1 to
Terms{values={core_node22=0}, version=0}
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:38395/wc/cd/collection1_shard1_replica_n21/
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.SyncStrategy
http://127.0.0.1:38395/wc/cd/collection1_shard1_replica_n21/ has no replicas
[junit4] 2> 2971683 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 2971687 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:38395/wc/cd/collection1_shard1_replica_n21/ shard1
[junit4] 2> 2971737 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 2971740 INFO (qtp298502552-18977) [n:127.0.0.1:38395_wc%2Fcd
c:collection1 s:shard1 x:collection1_shard1_replica_n21] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n21&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1325
[junit4] 2> 2971743 INFO (qtp739036438-18930) [n:127.0.0.1:34655_wc%2Fcd
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:38395_wc%252Fcd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=1348
[junit4] 2> 2971917 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.RestartWhileUpdatingTest_924B239A0D0C5F23-001/shard-2-001
of type NRT
[junit4] 2> 2971917 INFO
(TEST-RestartWhileUpdatingTest.test-seed#[924B239A0D0C5F23]) [ ]
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523c
[...truncated too long message...]
er.java:1595)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
[junit4] 1> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
[junit4] 1> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
[junit4] 1> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
[junit4] 1> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
[junit4] 1> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724)
[junit4] 1> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
[junit4] 1> at
org.eclipse.jetty.server.Server.handle(Server.java:531)
[junit4] 1> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
[junit4] 1> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
[junit4] 1> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
[junit4] 1> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
[junit4] 1> at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
[junit4] 1> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
[junit4] 1> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
[junit4] 1> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
[junit4] 1> at java.lang.Thread.run(Thread.java:748)
[junit4] 1>
[junit4] 1> 19:51:08.018 [qtp1329498682-1347] ERROR
org.apache.solr.handler.RequestHandlerBase -
org.apache.solr.common.SolrException: Unsupported operation: foobar
[junit4] 1> at
org.apache.solr.handler.admin.CoreAdminHandler.handleCustomAction(CoreAdminHandler.java:220)
[junit4] 1> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:169)
[junit4] 1> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
[junit4] 1> at
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:734)
[junit4] 1> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:715)
[junit4] 1> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:496)
[junit4] 1> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377)
[junit4] 1> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323)
[junit4] 1> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
[junit4] 1> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 1> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642)
[junit4] 1> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
[junit4] 1> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255)
[junit4] 1> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203)
[junit4] 1> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
[junit4] 1> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201)
[junit4] 1> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
[junit4] 1> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
[junit4] 1> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724)
[junit4] 1> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
[junit4] 1> at
org.eclipse.jetty.server.Server.handle(Server.java:531)
[junit4] 1> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
[junit4] 1> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
[junit4] 1> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
[junit4] 1> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
[junit4] 1> at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
[junit4] 1> at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
[junit4] 1> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
[junit4] 1> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
[junit4] 1> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
[junit4] 1> at java.lang.Thread.run(Thread.java:748)
[junit4] 1>
[junit4] 1> 19:51:09.005
[TEST-CloudSolrClientTest.testShutdown-seed#[DC1DE2A20FADEA32]-SendThread(ff01::114:33332)]
ERROR org.apache.zookeeper.ClientCnxnSocketNIO - Unable to open socket to
ff01::114/ff01:0:0:0:0:0:0:114:33332
[junit4] 1> 19:51:10.117
[TEST-CloudSolrClientTest.testShutdown-seed#[DC1DE2A20FADEA32]-SendThread(ff01::114:33332)]
ERROR org.apache.zookeeper.ClientCnxnSocketNIO - Unable to open socket to
ff01::114/ff01:0:0:0:0:0:0:114:33332
[junit4] 1> 19:51:11.792
[SUITE-CloudSolrClientTest-seed#[DC1DE2A20FADEA32]-worker] ERROR
org.apache.zookeeper.server.ZooKeeperServer - ZKShutdownHandler is not
registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN
server state changes
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_DC1DE2A20FADEA32-001
[junit4] 2> Nov 26, 2018 7:51:12 PM
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(Lucene70):
{multiDefault=FST50, a_t=Lucene50(blocksize=128), title_s=FST50,
id=PostingsFormat(name=Asserting), text=PostingsFormat(name=Memory)},
docValues:{_version_=DocValuesFormat(name=Memory),
multiDefault=DocValuesFormat(name=Lucene70), a_t=DocValuesFormat(name=Memory),
title_s=DocValuesFormat(name=Lucene70),
intDefault=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Direct),
text=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Memory)},
maxPointsInLeafNode=1728, maxMBSortInHeap=5.142377142916043,
sim=RandomSimilarity(queryNorm=true): {}, locale=mk-MK, timezone=Asia/Kolkata
[junit4] 2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation
1.8.0_191 (64-bit)/cpus=4,threads=1,free=177722072,total=384827392
[junit4] 2> NOTE: All tests run in this JVM: [TangentEvaluatorTest,
DomainMapTest, UuidEvaluatorTest, ExclusiveOrEvaluatorTest,
LargeVolumeBinaryJettyTest, OperationsTest, TestCollectionAdminRequest,
JDBCStreamTest, CloudSolrClientBuilderTest, CoalesceEvaluatorTest,
CommonAdminParamsTest, TestDelegationTokenRequest, GraphTest,
FieldAnalysisResponseTest, ZkConfigFilesTest, TestRetryUtil,
SolrExampleStreamingBinaryTest, QueryFacetMapTest, RegressionEvaluatorTest,
DivideEvaluatorTest, AnlysisResponseBaseTest, LBHttpSolrClientBuilderTest,
HttpClientUtilTest, Utf8CharSequenceTest, TestSpellCheckResponse,
SolrExampleBinaryTest, GreaterThanEqualToEvaluatorTest, AddEvaluatorTest,
ArrayEvaluatorTest, SolrExampleXMLTest, SolrExceptionTest, SolrQueryTest,
SolrSchemalessExampleTest, TestBatchUpdate, TestLBHttpSolrClient,
TestSolrJErrorHandling, SolrExampleStreamingTest, CloudSolrClientTest]
[junit4] Completed [132/174 (1!)] on J2 in 72.57s, 16 tests, 1 error <<<
FAILURES!
[...truncated 8066 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:651:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:585:
Some of the tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid26687.hprof
Total time: 274 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
