Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/255/
5 tests failed.
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([4A3A9C4E9A25D1C6:C26EA39434D9BC3E]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:188)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:862)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1418)
at
org.apache.solr.cloud.RestartWhileUpdatingTest.test(RestartWhileUpdatingTest.java:144)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.RestartWhileUpdatingTest
Error Message:
6 threads leaked from SUITE scope at
org.apache.solr.cloud.RestartWhileUpdatingTest: 1) Thread[id=121989,
name=searcherExecutor-9874-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 2) Thread[id=122222,
name=searcherExecutor-9936-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 3) Thread[id=122194,
name=searcherExecutor-9925-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 4) Thread[id=122250,
name=searcherExecutor-9947-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 5) Thread[id=122084,
name=searcherExecutor-9907-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 6) Thread[id=122022,
name=searcherExecutor-9885-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE
scope at org.apache.solr.cloud.RestartWhileUpdatingTest:
1) Thread[id=121989, name=searcherExecutor-9874-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=122222, name=searcherExecutor-9936-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
3) Thread[id=122194, name=searcherExecutor-9925-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
4) Thread[id=122250, name=searcherExecutor-9947-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
5) Thread[id=122084, name=searcherExecutor-9907-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
6) Thread[id=122022, name=searcherExecutor-9885-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6]: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=121989, name=searcherExecutor-9874-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 2) Thread[id=122222,
name=searcherExecutor-9936-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 3) Thread[id=122194,
name=searcherExecutor-9925-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 4) Thread[id=122250,
name=searcherExecutor-9947-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 5) Thread[id=122084,
name=searcherExecutor-9907-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745) 6) Thread[id=122022,
name=searcherExecutor-9885-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=121989, name=searcherExecutor-9874-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
2) Thread[id=122222, name=searcherExecutor-9936-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
3) Thread[id=122194, name=searcherExecutor-9925-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
4) Thread[id=122250, name=searcherExecutor-9947-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
5) Thread[id=122084, name=searcherExecutor-9907-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
6) Thread[id=122022, name=searcherExecutor-9885-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:1067)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6]:0)
FAILED: org.apache.solr.cloud.hdfs.HdfsSyncSliceTest.test
Error Message:
timeout waiting to see all nodes active
Stack Trace:
java.lang.AssertionError: timeout waiting to see all nodes active
at
__randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6:C26EA39434D9BC3E]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SyncSliceTest.waitTillAllNodesActive(SyncSliceTest.java:235)
at org.apache.solr.cloud.SyncSliceTest.test(SyncSliceTest.java:164)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6:C26EA39434D9BC3E]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest.test(HdfsWriteToMultipleCollectionsTest.java:137)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11311 lines...]
[junit4] Suite: org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/init-core-data-001
[junit4] 2> 26125 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 26126 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 26798 WARN
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 27501 WARN
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 27694 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
[junit4] 2> 27714 WARN
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 27773 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 27811 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_39409_hdfs____.z5oain/webapp
[junit4] 2> 28569 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:39409
[junit4] 2> 29355 WARN
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 29359 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 29371 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_48214_datanode____.wb9io8/webapp
[junit4] 2> 31097 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:48214
[junit4] 2> 31638 WARN
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 31645 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 31673 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_38714_datanode____.12bczo/webapp
[junit4] 2> 32192 INFO
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[4A3A9C4E9A25D1C6]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:38714
[junit4] 2> 34534 INFO (IPC Server handler 8 on 57139) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-15a89b50-290a-45c4-a11b-437d53428eaa node
DatanodeRegistration(127.0.0.1:43295,
datanodeUuid=2b3ea496-184b-4ef2-b953-a7af40a4ce13, infoPort=45366,
infoSecurePort=0, ipcPort=41561,
storageInfo=lv=-56;cid=testClusterID;nsid=1084783039;c=0), blocks: 0,
hasStaleStorage: true, processing time: 2 msecs
[junit4] 2> 34534 INFO (IPC Server handler 8 on 57139) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-c02c68d2-056a-4c5c-83c8-3e66b3e6b75f node
DatanodeRegistration(127.0.0.1:43295,
datanodeUuid=2b3ea496-184b-4ef2-b953-a7af40a4ce13, infoPort=45366,
infoSecurePort=0, ipcPort=41561,
storageInfo=lv=-56;cid=testClusterID;nsid=1084783039;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 34543 INFO (IPC Server handler 4 on 57139) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-eb1107da-ba61-4cde-af6c-b87a92a6c406 node
DatanodeRegistration(127.0.0.1:37617,
datanodeUuid=f998277d-c640-4f87-8d09-9b57ec055897, infoPort=46959,
infoSecurePort=0, ipcPort=42776,
storageInfo=lv=-56;cid=testClusterID;nsid=1084783039;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 34543 INFO (IPC Server handler 4 on 57139) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-2edd29d4-a1ce-4585-adb9-271553984200 node
DatanodeRegistration(127.0.0.1:37617,
datanodeUuid=f998277d-c640-4f87-8d09-9b57ec055897, infoPort=46959,
infoSecurePort=0, ipcPort=42776,
storageInfo=lv=-56;cid=testClusterID;nsid=1084783039;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 34723 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 34725 INFO (Thread-201) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 34726 INFO (Thread-201) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 34924 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ZkTestServer start zk server on port:58772
[junit4] 2> 35026 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 35028 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 35029 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 35030 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 35032 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 35036 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 35037 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 35038 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 35039 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 35040 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 35041 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 35193 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/control-001/cores/collection1
[junit4] 2> 35207 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 35217 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@535e81ed{/,null,AVAILABLE}
[junit4] 2> 35218 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@348e6398{HTTP/1.1,[http/1.1]}{127.0.0.1:47626}
[junit4] 2> 35218 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server Started @38092ms
[junit4] 2> 35218 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57139/hdfs__localhost_57139__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001_tempDir-002_control_data,
hostContext=/, hostPort=47626,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/control-001/cores}
[junit4] 2> 35218 ERROR
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 35218 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 35219 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 35219 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 35219 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-12T12:58:11.595Z
[junit4] 2> 35331 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 35331 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/control-001/solr.xml
[junit4] 2> 35367 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 35375 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58772/solr
[junit4] 2> 35432 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:47626_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:47626_
[junit4] 2> 35435 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:47626_ ] o.a.s.c.Overseer Overseer
(id=97270228000112644-127.0.0.1:47626_-n_0000000000) starting
[junit4] 2> 35469 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:47626_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:47626_
[junit4] 2> 35470 INFO
(zkCallback-81-thread-1-processing-n:127.0.0.1:47626_) [n:127.0.0.1:47626_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 35543 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:47626_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/control-001/cores
[junit4] 2> 35546 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:47626_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 35584 INFO
(OverseerStateUpdate-97270228000112644-127.0.0.1:47626_-n_0000000000)
[n:127.0.0.1:47626_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 35648 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 35725 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 36372 WARN
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 36380 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 36508 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 36514 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57139/solr_hdfs_home
[junit4] 2> 36514 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 36514 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/control-001/cores/collection1],
dataDir=[hdfs://localhost:57139/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 36514 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a7bae30
[junit4] 2> 36522 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/control_collection/core_node1/data/snapshot_metadata
[junit4] 2> 36599 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 36599 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 36599 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new global HDFS BlockCache
[junit4] 2> 38779 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 38787 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 39123 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 39143 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 39143 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 39153 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 39154 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=50, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.466796875,
noCFSRatio=0.843716224770874]
[junit4] 2> 39544 INFO (IPC Server handler 6 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37617 is
added to blk_1073741825_1001{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-2edd29d4-a1ce-4585-adb9-271553984200:NORMAL:127.0.0.1:37617|RBW],
ReplicaUC[[DISK]DS-c02c68d2-056a-4c5c-83c8-3e66b3e6b75f:NORMAL:127.0.0.1:43295|RBW]]}
size 71
[junit4] 2> 39544 INFO (IPC Server handler 0 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43295 is
added to blk_1073741825_1001 size 71
[junit4] 2> 39990 WARN
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
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> 40007 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 40007 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 40007 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.HdfsUpdateLog
Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 40022 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 40022 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 40025 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1536824939,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 40095 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@45be7a48[collection1] main]
[junit4] 2> 40098 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 40099 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 40101 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 40106 INFO
(searcherExecutor-92-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@45be7a48[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 40112 INFO
(coreLoadExecutor-91-thread-1-processing-n:127.0.0.1:47626_)
[n:127.0.0.1:47626_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1556323653635801088
[junit4] 2> 40132 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 40132 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 40132 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:47626/collection1/
[junit4] 2> 40133 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 40134 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:47626/collection1/ has no replicas
[junit4] 2> 40153 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:47626/collection1/ shard1
[junit4] 2> 40304 INFO
(coreZkRegister-84-thread-1-processing-n:127.0.0.1:47626_ x:collection1
c:control_collection) [n:127.0.0.1:47626_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 40599 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 40600 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58772/solr ready
[junit4] 2> 40601 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 40705 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001/cores/collection1
[junit4] 2> 40706 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001
[junit4] 2> 40707 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 40708 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2257d655{/,null,AVAILABLE}
[junit4] 2> 40708 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@747c7803{HTTP/1.1,[http/1.1]}{127.0.0.1:57069}
[junit4] 2> 40708 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server Started @43582ms
[junit4] 2> 40708 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57139/hdfs__localhost_57139__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=57069,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001/cores}
[junit4] 2> 40709 ERROR
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 40710 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 40710 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 40710 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 40710 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-12T12:58:17.086Z
[junit4] 2> 40726 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 40726 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001/solr.xml
[junit4] 2> 40734 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 40735 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58772/solr
[junit4] 2> 40749 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:57069_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 40761 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:57069_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57069_
[junit4] 2> 40765 INFO (zkCallback-85-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 40765 INFO
(zkCallback-81-thread-2-processing-n:127.0.0.1:47626_) [n:127.0.0.1:47626_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 40775 INFO
(zkCallback-90-thread-1-processing-n:127.0.0.1:57069_) [n:127.0.0.1:57069_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 40850 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:57069_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001/cores
[junit4] 2> 40851 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:57069_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 40889 INFO
(OverseerStateUpdate-97270228000112644-127.0.0.1:47626_-n_0000000000)
[n:127.0.0.1:47626_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 41924 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.4.0
[junit4] 2> 41952 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 42063 WARN
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 42065 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 42160 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 42160 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57139/solr_hdfs_home
[junit4] 2> 42175 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Solr Kerberos Authentication disabled
[junit4] 2> 42175 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-1-001/cores/collection1],
dataDir=[hdfs://localhost:57139/solr_hdfs_home/collection1/core_node1/data/]
[junit4] 2> 42175 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@a7bae30
[junit4] 2> 42176 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node1/data/snapshot_metadata
[junit4] 2> 42199 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 42199 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Block cache target memory usage, slab size of [8388608] will allocate [1] slabs
and use ~[8388608] bytes
[junit4] 2> 42207 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 42210 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node1/data
[junit4] 2> 42250 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node1/data/index
[junit4] 2> 42261 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 42261 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Block cache target memory usage, slab size of [8388608] will allocate [1] slabs
and use ~[8388608] bytes
[junit4] 2> 42268 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 42269 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=50,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.466796875,
noCFSRatio=0.843716224770874]
[junit4] 2> 42370 INFO (IPC Server handler 2 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37617 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-15a89b50-290a-45c4-a11b-437d53428eaa:NORMAL:127.0.0.1:43295|RBW],
ReplicaUC[[DISK]DS-2edd29d4-a1ce-4585-adb9-271553984200:NORMAL:127.0.0.1:37617|RBW]]}
size 0
[junit4] 2> 42376 INFO (IPC Server handler 4 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43295 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-2edd29d4-a1ce-4585-adb9-271553984200:NORMAL:127.0.0.1:37617|RBW],
ReplicaUC[[DISK]DS-c02c68d2-056a-4c5c-83c8-3e66b3e6b75f:NORMAL:127.0.0.1:43295|FINALIZED]]}
size 0
[junit4] 2> 42392 WARN
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] 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> 42503 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 42503 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 42503 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.HdfsUpdateLog
Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 42535 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 42535 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 42544 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1536824939,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 42554 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@6b550697[collection1] main]
[junit4] 2> 42555 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 42556 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 42556 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 42558 INFO
(searcherExecutor-103-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6b550697[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 42561 INFO
(coreLoadExecutor-102-thread-1-processing-n:127.0.0.1:57069_)
[n:127.0.0.1:57069_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1556323656203763712
[junit4] 2> 42608 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 42608 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 42608 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:57069/collection1/
[junit4] 2> 42609 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 42609 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:57069/collection1/ has no
replicas
[junit4] 2> 42613 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:57069/collection1/ shard1
[junit4] 2> 42766 INFO
(coreZkRegister-97-thread-1-processing-n:127.0.0.1:57069_ x:collection1
c:collection1) [n:127.0.0.1:57069_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 42950 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001/cores/collection1
[junit4] 2> 42950 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001
[junit4] 2> 42968 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43002 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@76ffdf4a{/,null,AVAILABLE}
[junit4] 2> 43002 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@31305988{HTTP/1.1,[http/1.1]}{127.0.0.1:54250}
[junit4] 2> 43002 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.e.j.s.Server Started @45876ms
[junit4] 2> 43003 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57139/hdfs__localhost_57139__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001_tempDir-002_jetty2,
solrconfig=solrconfig.xml, hostContext=/, hostPort=54250,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001/cores}
[junit4] 2> 43003 ERROR
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 43007 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 43007 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43007 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43007 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-12T12:58:19.383Z
[junit4] 2> 43099 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 43099 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001/solr.xml
[junit4] 2> 43112 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 43114 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58772/solr
[junit4] 2> 43216 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:54250_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 43225 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:54250_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54250_
[junit4] 2> 43226 INFO
(zkCallback-90-thread-1-processing-n:127.0.0.1:57069_) [n:127.0.0.1:57069_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 43230 INFO (zkCallback-85-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 43230 INFO
(zkCallback-81-thread-1-processing-n:127.0.0.1:47626_) [n:127.0.0.1:47626_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 43267 INFO
(zkCallback-96-thread-2-processing-n:127.0.0.1:54250_) [n:127.0.0.1:54250_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 43341 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:54250_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001/cores
[junit4] 2> 43341 INFO
(TEST-HdfsWriteToMultipleCollectionsTest.test-seed#[4A3A9C4E9A25D1C6])
[n:127.0.0.1:54250_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 43389 INFO
(OverseerStateUpdate-97270228000112644-127.0.0.1:47626_-n_0000000000)
[n:127.0.0.1:47626_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 44493 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.4.0
[junit4] 2> 44552 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 44692 WARN
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 44693 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 44711 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 44712 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57139/solr_hdfs_home
[junit4] 2> 44712 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Solr Kerberos Authentication disabled
[junit4] 2> 44712 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_4A3A9C4E9A25D1C6-001/shard-2-001/cores/collection1],
dataDir=[hdfs://localhost:57139/solr_hdfs_home/collection1/core_node2/data/]
[junit4] 2> 44712 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@a7bae30
[junit4] 2> 44712 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node2/data/snapshot_metadata
[junit4] 2> 44719 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 44719 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Block cache target memory usage, slab size of [8388608] will allocate [1] slabs
and use ~[8388608] bytes
[junit4] 2> 44739 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 44742 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node2/data
[junit4] 2> 44783 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
creating directory factory for path
hdfs://localhost:57139/solr_hdfs_home/collection1/core_node2/data/index
[junit4] 2> 44938 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 44938 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory
Block cache target memory usage, slab size of [8388608] will allocate [1] slabs
and use ~[8388608] bytes
[junit4] 2> 44942 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 44945 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=50,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.466796875,
noCFSRatio=0.843716224770874]
[junit4] 2> 45083 INFO (IPC Server handler 5 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37617 is
added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-15a89b50-290a-45c4-a11b-437d53428eaa:NORMAL:127.0.0.1:43295|RBW],
ReplicaUC[[DISK]DS-eb1107da-ba61-4cde-af6c-b87a92a6c406:NORMAL:127.0.0.1:37617|RBW]]}
size 0
[junit4] 2> 45085 INFO (IPC Server handler 1 on 57139) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43295 is
added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-15a89b50-290a-45c4-a11b-437d53428eaa:NORMAL:127.0.0.1:43295|RBW],
ReplicaUC[[DISK]DS-eb1107da-ba61-4cde-af6c-b87a92a6c406:NORMAL:127.0.0.1:37617|RBW]]}
size 0
[junit4] 2> 45101 WARN
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] 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> 45161 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 45162 INFO
(coreLoadExecutor-113-thread-1-processing-n:127.0.0.1:54250_)
[n:127.0.0.1:54250_ c:collection1 x:collec
[...truncated too long message...]
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 3) Thread[id=122194, name=searcherExecutor-9925-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 4) Thread[id=122250, name=searcherExecutor-9947-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 5) Thread[id=122084, name=searcherExecutor-9907-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 6) Thread[id=122022, name=searcherExecutor-9885-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=121989, name=searcherExecutor-9874-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 2) Thread[id=122222, name=searcherExecutor-9936-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 3) Thread[id=122194, name=searcherExecutor-9925-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 4) Thread[id=122250, name=searcherExecutor-9947-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 5) Thread[id=122084, name=searcherExecutor-9907-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 6) Thread[id=122022, name=searcherExecutor-9885-thread-1,
state=WAITING, group=TGRP-RestartWhileUpdatingTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([4A3A9C4E9A25D1C6]:0)
[junit4] Completed [307/680 (3!)] on J2 in 387.58s, 1 test, 1 failure, 2
errors <<< FAILURES!
[...truncated 63605 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
