Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.6/34/
5 tests failed.
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Something is broken in the assert for no shards using the same indexDir -
probably something was changed in the attributes published in the MBean of
SolrCore : {}
Stack Trace:
java.lang.AssertionError: Something is broken in the assert for no shards using
the same indexDir - probably something was changed in the attributes published
in the MBean of SolrCore : {}
at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD:30BBF298A13E0F48]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.checkNoTwoShardsUseTheSameIndexDir(CollectionsAPIDistributedZkTest.java:646)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:524)
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
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.admin.MetricsHandlerTest.test
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD:F09AB9F609F14D25]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at org.junit.Assert.assertNotNull(Assert.java:537)
at
org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:54)
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
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.update.TestInPlaceUpdatesDistrib.test
Error Message:
Error from server at https://127.0.0.1:46742/t_r/y/collection1: Expected mime
type application/octet-stream but got text/html. <html> <head> <meta
http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error
500 </title> </head> <body> <h2>HTTP ERROR: 500</h2> <p>Problem accessing
/t_r/y/collection1/update. Reason: <pre> java.lang.OutOfMemoryError: GC
overhead limit exceeded</pre></p> <hr /><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.3.14.v20161028</a><hr/>
</body> </html>
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at https://127.0.0.1:46742/t_r/y/collection1: Expected mime type
application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 500 </title>
</head>
<body>
<h2>HTTP ERROR: 500</h2>
<p>Problem accessing /t_r/y/collection1/update. Reason:
<pre> java.lang.OutOfMemoryError: GC overhead limit exceeded</pre></p>
<hr /><a href="http://eclipse.org/jetty";>Powered by Jetty://
9.3.14.v20161028</a><hr/>
</body>
</html>
at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD:F09AB9F609F14D25]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:580)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:177)
at
org.apache.solr.update.TestInPlaceUpdatesDistrib.addDocAndGetVersion(TestInPlaceUpdatesDistrib.java:1078)
at
org.apache.solr.update.TestInPlaceUpdatesDistrib.buildRandomIndex(TestInPlaceUpdatesDistrib.java:1123)
at
org.apache.solr.update.TestInPlaceUpdatesDistrib.docValuesUpdateTest(TestInPlaceUpdatesDistrib.java:327)
at
org.apache.solr.update.TestInPlaceUpdatesDistrib.test(TestInPlaceUpdatesDistrib.java:154)
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:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
junit.framework.TestSuite.org.apache.solr.update.TestInPlaceUpdatesDistrib
Error Message:
2 threads leaked from SUITE scope at
org.apache.solr.update.TestInPlaceUpdatesDistrib: 1) Thread[id=63443,
name=searcherExecutor-10694-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=63409,
name=searcherExecutor-10683-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE
scope at org.apache.solr.update.TestInPlaceUpdatesDistrib:
1) Thread[id=63443, name=searcherExecutor-10694-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=63409, name=searcherExecutor-10683-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([78CE862CA70D20DD]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.update.TestInPlaceUpdatesDistrib
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=63443, name=searcherExecutor-10694-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748) 2) Thread[id=63409,
name=searcherExecutor-10683-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib] at sun.misc.Unsafe.park(Native
Method) at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=63443, name=searcherExecutor-10694-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
2) Thread[id=63409, name=searcherExecutor-10683-thread-1, state=WAITING,
group=TGRP-TestInPlaceUpdatesDistrib]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([78CE862CA70D20DD]:0)
Build Log:
[...truncated 12004 lines...]
[junit4] Suite: org.apache.solr.handler.admin.MetricsHandlerTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_78CE862CA70D20DD-001/init-core-data-001
[junit4] 2> 242026 WARN
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
[junit4] 2> 242026 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 242028 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 242029 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 242030 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 242081 WARN
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 242083 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.3
[junit4] 2> 242114 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 243050 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 243062 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 243093 WARN
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 243093 WARN
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 243093 WARN
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via
JMX.
[junit4] 2> 243094 INFO (coreLoadExecutor-1476-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 243096 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 243133 WARN (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 243135 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.3
[junit4] 2> 243165 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 243306 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 243314 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 243314 WARN (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr
metrics via JMX.
[junit4] 2> 243314 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 243315 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_78CE862CA70D20DD-001/init-core-data-001/]
[junit4] 2> 243317 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.41176649114580666]
[junit4] 2> 243383 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 243383 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 243384 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=6, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.0146484375,
noCFSRatio=0.4752696713000235]
[junit4] 2> 243396 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@75a7cdad[collection1] main]
[junit4] 2> 243397 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 243419 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 243456 INFO (coreLoadExecutor-1476-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 243456 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 243457 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 243457 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 243457 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 243457 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 243460 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 243461 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 243462 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 243463 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 243463 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 243464 INFO
(searcherExecutor-1477-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@75a7cdad[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 243464 INFO
(TEST-MetricsHandlerTest.testCompact-seed#[78CE862CA70D20DD]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testCompact
[junit4] 2> 243553 INFO
(TEST-MetricsHandlerTest.testCompact-seed#[78CE862CA70D20DD]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testCompact
[junit4] 2> 243555 INFO
(TEST-MetricsHandlerTest.test-seed#[78CE862CA70D20DD]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 243581 INFO
(TEST-MetricsHandlerTest.test-seed#[78CE862CA70D20DD]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MetricsHandlerTest
-Dtests.method=test -Dtests.seed=78CE862CA70D20DD -Dtests.multiplier=2
-Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/test-data/enwiki.random.lines.txt
-Dtests.locale=es-VE -Dtests.timezone=Pacific/Kiritimati -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.03s J2 | MetricsHandlerTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError
[junit4] > at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD:F09AB9F609F14D25]:0)
[junit4] > at
org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:54)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=178690372
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@25f00628: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ null
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jvm
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2b4472db: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
null
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jetty
[junit4] 2> 243584 INFO
(SUITE-MetricsHandlerTest-seed#[78CE862CA70D20DD]-worker) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4ff1b81b: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / null
[junit4] 2> 243585 INFO (coreCloseExecutor-1481-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1c8dd5cd
[junit4] 2> 243592 INFO (coreCloseExecutor-1481-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 243592 INFO (coreCloseExecutor-1481-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@30a1bdef: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / null
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_78CE862CA70D20DD-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1765, maxMBSortInHeap=6.713281055499272,
sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=es-VE,
timezone=Pacific/Kiritimati
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_144 (64-bit)/cpus=4,threads=1,free=205503176,total=516947968
[junit4] 2> NOTE: All tests run in this JVM: [SolrJmxReporterCloudTest,
RecoveryZkTest, TestCollationFieldDocValues, TestUnifiedSolrHighlighter,
PluginInfoTest, TestLMJelinekMercerSimilarityFactory,
DeleteLastCustomShardedReplicaTest, TestTestInjection,
FieldMutatingUpdateProcessorTest, TestExceedMaxTermLength,
TestAnalyzedSuggestions, TestRestManager, TestClusterProperties,
TestMiniSolrCloudClusterSSL, TestPostingsSolrHighlighter,
SolrCoreCheckLockOnStartupTest, OutOfBoxZkACLAndCredentialsProvidersTest,
LeaderElectionTest, TestImpersonationWithHadoopAuth, TestSolrJ,
TestSolrDynamicMBean, MoveReplicaTest, TestTrackingShardHandlerFactory,
OverseerModifyCollectionTest, AddSchemaFieldsUpdateProcessorFactoryTest,
TestCloudDeleteByQuery, TestRecovery, TestCopyFieldCollectionResource,
QueryParsingTest, PrimUtilsTest, ClassificationUpdateProcessorFactoryTest,
TestRawResponseWriter, SharedFSAutoReplicaFailoverUtilsTest,
TestDynamicLoading, TestStressReorder, PeerSyncWithIndexFingerprintCachingTest,
CloudExitableDirectoryReaderTest, HttpSolrCallGetCoreTest, MetricsHandlerTest]
[junit4] Completed [65/714 (1!)] on J2 in 1.59s, 2 tests, 1 failure <<<
FAILURES!
[...truncated 1579 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/init-core-data-001
[junit4] 2> 3676714 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=48 numCloses=48
[junit4] 2> 3676715 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 3676716 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 3676717 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001
[junit4] 2> 3676717 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3676717 INFO (Thread-38667) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3676717 INFO (Thread-38667) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 3676724 ERROR (Thread-38667) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 3676817 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:51101
[junit4] 2> 3676824 INFO (jetty-launcher-4480-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3676829 INFO (jetty-launcher-4480-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3676829 INFO (jetty-launcher-4480-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3676829 INFO (jetty-launcher-4480-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3676837 INFO (jetty-launcher-4480-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@32e9e77b{/solr,null,AVAILABLE}
[junit4] 2> 3676843 INFO (jetty-launcher-4480-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1eac8a36{/solr,null,AVAILABLE}
[junit4] 2> 3676845 INFO (jetty-launcher-4480-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@164b0e94{/solr,null,AVAILABLE}
[junit4] 2> 3676849 INFO (jetty-launcher-4480-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@13679d23{HTTP/1.1,[http/1.1]}{127.0.0.1:53244}
[junit4] 2> 3676849 INFO (jetty-launcher-4480-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@7e8b00b0{HTTP/1.1,[http/1.1]}{127.0.0.1:35293}
[junit4] 2> 3676849 INFO (jetty-launcher-4480-thread-4) [ ]
o.e.j.s.Server Started @3679779ms
[junit4] 2> 3676849 INFO (jetty-launcher-4480-thread-1) [ ]
o.e.j.s.Server Started @3679779ms
[junit4] 2> 3676849 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=53244}
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35293}
[junit4] 2> 3676850 ERROR (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.6.3
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-04T09:41:37Z
[junit4] 2> 3676850 ERROR (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3676851 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.6.3
[junit4] 2> 3676851 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3676851 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3676851 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-04T09:41:37.001Z
[junit4] 2> 3676850 INFO (jetty-launcher-4480-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@19072b2f{HTTP/1.1,[http/1.1]}{127.0.0.1:38931}
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.e.j.s.Server Started @3679782ms
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38931}
[junit4] 2> 3676852 ERROR (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.6.3
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3676852 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-04T09:41:37.002Z
[junit4] 2> 3676853 INFO (jetty-launcher-4480-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@793c289{/solr,null,AVAILABLE}
[junit4] 2> 3676855 INFO (jetty-launcher-4480-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@65cc7b8c{HTTP/1.1,[http/1.1]}{127.0.0.1:57105}
[junit4] 2> 3676859 INFO (jetty-launcher-4480-thread-3) [ ]
o.e.j.s.Server Started @3679789ms
[junit4] 2> 3676859 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57105}
[junit4] 2> 3676865 ERROR (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3676865 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.6.3
[junit4] 2> 3676865 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3676865 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3676865 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-03-04T09:41:37.015Z
[junit4] 2> 3676867 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3676867 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3676873 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3676873 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3676878 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3676879 INFO (jetty-launcher-4480-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51101/solr
[junit4] 2> 3676882 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3676883 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3676884 INFO (jetty-launcher-4480-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51101/solr
[junit4] 2> 3676885 INFO (jetty-launcher-4480-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51101/solr
[junit4] 2> 3676886 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3676886 INFO (jetty-launcher-4480-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51101/solr
[junit4] 2> 3676887 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x161f06353e50006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 3676910 INFO (jetty-launcher-4480-thread-1)
[n:127.0.0.1:35293_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3676910 INFO (jetty-launcher-4480-thread-4)
[n:127.0.0.1:53244_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3676910 INFO (jetty-launcher-4480-thread-3)
[n:127.0.0.1:57105_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3676910 INFO (jetty-launcher-4480-thread-2)
[n:127.0.0.1:38931_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3676911 INFO (jetty-launcher-4480-thread-3)
[n:127.0.0.1:57105_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:57105_solr
[junit4] 2> 3676912 INFO (jetty-launcher-4480-thread-4)
[n:127.0.0.1:53244_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53244_solr
[junit4] 2> 3676912 INFO (jetty-launcher-4480-thread-2)
[n:127.0.0.1:38931_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38931_solr
[junit4] 2> 3676912 INFO (jetty-launcher-4480-thread-1)
[n:127.0.0.1:35293_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35293_solr
[junit4] 2> 3676912 INFO (jetty-launcher-4480-thread-3)
[n:127.0.0.1:57105_solr ] o.a.s.c.Overseer Overseer
(id=99624976178806796-127.0.0.1:57105_solr-n_0000000000) starting
[junit4] 2> 3676914 INFO
(zkCallback-4500-thread-1-processing-n:127.0.0.1:53244_solr)
[n:127.0.0.1:53244_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 3676914 INFO
(zkCallback-4496-thread-1-processing-n:127.0.0.1:35293_solr)
[n:127.0.0.1:35293_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 3676914 INFO
(zkCallback-4502-thread-1-processing-n:127.0.0.1:57105_solr)
[n:127.0.0.1:57105_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 3676922 INFO
(zkCallback-4501-thread-1-processing-n:127.0.0.1:38931_solr)
[n:127.0.0.1:38931_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 3676935 INFO (jetty-launcher-4480-thread-3)
[n:127.0.0.1:57105_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57105_solr
[junit4] 2> 3676937 INFO
(zkCallback-4501-thread-1-processing-n:127.0.0.1:38931_solr)
[n:127.0.0.1:38931_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3676937 INFO
(zkCallback-4496-thread-1-processing-n:127.0.0.1:35293_solr)
[n:127.0.0.1:35293_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3676937 INFO
(zkCallback-4500-thread-1-processing-n:127.0.0.1:53244_solr)
[n:127.0.0.1:53244_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3676937 INFO
(zkCallback-4502-thread-1-processing-n:127.0.0.1:57105_solr)
[n:127.0.0.1:57105_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3676965 INFO (jetty-launcher-4480-thread-2)
[n:127.0.0.1:38931_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node3/.
[junit4] 2> 3676965 INFO (jetty-launcher-4480-thread-4)
[n:127.0.0.1:53244_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node4/.
[junit4] 2> 3676989 INFO (jetty-launcher-4480-thread-1)
[n:127.0.0.1:35293_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node1/.
[junit4] 2> 3676995 INFO (jetty-launcher-4480-thread-3)
[n:127.0.0.1:57105_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node2/.
[junit4] 2> 3677005 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3677006 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51101/solr ready
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 3677057 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 3677065 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3677077 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 3677099 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_41817_hdfs____mmu3xn/webapp
[junit4] 2> 3677502 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41817
[junit4] 2> 3677560 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3677561 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 3677575 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_45588_datanode____.a4fgw5/webapp
[junit4] 2> 3678003 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[78CE862CA70D20DD]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:45588
[junit4] 2> 3678088 ERROR (DataNode:
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-002/hdfsBaseDir/data/data1/,
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-002/hdfsBaseDir/data/data2/]]
heartbeating to localhost/127.0.0.1:52843) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 3678094 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x48815576400c08: from storage
DS-ff004887-7b11-462a-bc33-2e49b7d936dc node
DatanodeRegistration(127.0.0.1:50209,
datanodeUuid=61a0fe6e-62b9-4c1f-a6ae-3e29a3811d18, infoPort=51077,
infoSecurePort=0, ipcPort=49138,
storageInfo=lv=-56;cid=testClusterID;nsid=1545822465;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 3678094 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0x48815576400c08: from storage
DS-31e16253-85d5-470b-8675-76bdaa74acd0 node
DatanodeRegistration(127.0.0.1:50209,
datanodeUuid=61a0fe6e-62b9-4c1f-a6ae-3e29a3811d18, infoPort=51077,
infoSecurePort=0, ipcPort=49138,
storageInfo=lv=-56;cid=testClusterID;nsid=1545822465;c=0), blocks: 0,
hasStaleStorage: false, processing time: 1 msecs
[junit4] 2> 3678208 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.addReplicaTest-seed#[78CE862CA70D20DD])
[ ] o.a.s.SolrTestCaseJ4 ###Starting addReplicaTest
[junit4] 2> 3678210 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.addReplicaTest-seed#[78CE862CA70D20DD])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3678214 INFO (qtp1613196478-56381) [n:127.0.0.1:53244_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=4&name=addReplicaColl&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 3678217 INFO
(OverseerThreadFactory-8695-thread-1-processing-n:127.0.0.1:57105_solr)
[n:127.0.0.1:57105_solr ] o.a.s.c.CreateCollectionCmd Create collection
addReplicaColl
[junit4] 2> 3678323 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 3678323 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 3678323 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 3678324 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 3678325 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica2&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 3678325 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 3678326 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica2&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 3678326 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 3678433 INFO
(zkCallback-4500-thread-1-processing-n:127.0.0.1:53244_solr)
[n:127.0.0.1:53244_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3678433 INFO
(zkCallback-4501-thread-1-processing-n:127.0.0.1:38931_solr)
[n:127.0.0.1:38931_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3678433 INFO
(zkCallback-4496-thread-1-processing-n:127.0.0.1:35293_solr)
[n:127.0.0.1:35293_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3678433 INFO
(zkCallback-4502-thread-1-processing-n:127.0.0.1:57105_solr)
[n:127.0.0.1:57105_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3679343 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.3
[junit4] 2> 3679344 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.3
[junit4] 2> 3679344 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.3
[junit4] 2> 3679371 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.3
[junit4] 2> 3679376 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica1] Schema name=minimal
[junit4] 2> 3679379 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3679379 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica1' using
configuration from collection addReplicaColl, trusted=true
[junit4] 2> 3679380 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica2] Schema name=minimal
[junit4] 2> 3679380 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica2] Schema name=minimal
[junit4] 2> 3679382 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3679382 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard2_replica2' using
configuration from collection addReplicaColl, trusted=true
[junit4] 2> 3679384 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3679384 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica2' using
configuration from collection addReplicaColl, trusted=true
[junit4] 2> 3679388 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52843/data
[junit4] 2> 3679388 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3679388 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3679388 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52843/data
[junit4] 2> 3679388 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.c.SolrCore
[[addReplicaColl_shard1_replica1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node3/addReplicaColl_shard1_replica1],
dataDir=[hdfs://localhost:52843/data/addReplicaColl/core_node1/data/]
[junit4] 2> 3679388 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3679388 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3679388 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.c.SolrCore
[[addReplicaColl_shard1_replica2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node4/addReplicaColl_shard1_replica2],
dataDir=[hdfs://localhost:52843/data/addReplicaColl/core_node3/data/]
[junit4] 2> 3679389 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52843/data
[junit4] 2> 3679389 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3679389 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3679389 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.c.SolrCore
[[addReplicaColl_shard2_replica2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node2/addReplicaColl_shard2_replica2],
dataDir=[hdfs://localhost:52843/data/addReplicaColl/core_node4/data/]
[junit4] 2> 3679389 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node1/data/snapshot_metadata
[junit4] 2> 3679389 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node3/data/snapshot_metadata
[junit4] 2> 3679389 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node4/data/snapshot_metadata
[junit4] 2> 3679393 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica1] Schema name=minimal
[junit4] 2> 3679396 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3679396 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard2_replica1' using
configuration from collection addReplicaColl, trusted=true
[junit4] 2> 3679396 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52843/data
[junit4] 2> 3679396 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3679397 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3679397 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1] o.a.s.c.SolrCore
[[addReplicaColl_shard2_replica1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_78CE862CA70D20DD-001/tempDir-001/node1/addReplicaColl_shard2_replica1],
dataDir=[hdfs://localhost:52843/data/addReplicaColl/core_node2/data/]
[junit4] 2> 3679397 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node2/data/snapshot_metadata
[junit4] 2> 3679413 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3679413 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3679413 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3679415 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3679415 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3679415 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3679415 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3679415 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3679415 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3679416 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3679416 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3679416 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3679424 WARN (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds
and try again.
[junit4] 2> 3679424 WARN (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds
and try again.
[junit4] 2> 3679425 WARN (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds
and try again.
[junit4] 2> 3679426 WARN (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds
and try again.
[junit4] 2> 3684431 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684433 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684436 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684436 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node3/data
[junit4] 2> 3684443 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684443 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node4/data
[junit4] 2> 3684446 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node2/data
[junit4] 2> 3684447 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node1/data
[junit4] 2> 3684468 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node3/data/index
[junit4] 2> 3684476 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3684477 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3684477 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3684477 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node4/data/index
[junit4] 2> 3684481 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684485 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node1/data/index
[junit4] 2> 3684486 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3684486 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3684486 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3684493 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684495 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52843/data/addReplicaColl/core_node2/data/index
[junit4] 2> 3684497 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3684497 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3684497 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3684503 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684509 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50209 is added to
blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-31e16253-85d5-470b-8675-76bdaa74acd0:NORMAL:127.0.0.1:50209|RBW]]}
size 0
[junit4] 2> 3684516 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3684516 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[4194304] will allocate [1] slabs and use ~[4194304] bytes
[junit4] 2> 3684516 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3684523 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3684536 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50209 is added to
blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-ff004887-7b11-462a-bc33-2e49b7d936dc:NORMAL:127.0.0.1:50209|FINALIZED]]}
size 0
[junit4] 2> 3684537 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50209 is added to
blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-31e16253-85d5-470b-8675-76bdaa74acd0:NORMAL:127.0.0.1:50209|RBW]]}
size 0
[junit4] 2> 3684598 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50209 is added to
blk_1073741828_1004{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-ff004887-7b11-462a-bc33-2e49b7d936dc:NORMAL:127.0.0.1:50209|FINALIZED]]}
size 0
[junit4] 2> 3684599 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3684599 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3684599 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3684626 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3684626 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3684635 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3684635 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3684635 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3684638 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3684638 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3684638 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3684652 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3684652 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@107e8137[addReplicaColl_shard1_replica2] main]
[junit4] 2> 3684652 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3684654 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 3684654 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 3684654 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3684655 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1593999627182407680
[junit4] 2> 3684657 INFO
(searcherExecutor-8706-thread-1-processing-n:127.0.0.1:53244_solr
x:addReplicaColl_shard1_replica2 s:shard1 c:addReplicaColl)
[n:127.0.0.1:53244_solr c:addReplicaColl s:shard1
x:addReplicaColl_shard1_replica2] o.a.s.c.SolrCore
[addReplicaColl_shard1_replica2] Registered new searcher
Searcher@107e8137[addReplicaColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3684661 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3684661 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3684663 INFO (qtp1613196478-56379) [n:127.0.0.1:53244_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 3684665 INFO
(zkCallback-4501-thread-1-processing-n:127.0.0.1:38931_solr)
[n:127.0.0.1:38931_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3684665 INFO
(zkCallback-4496-thread-1-processing-n:127.0.0.1:35293_solr)
[n:127.0.0.1:35293_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3684665 INFO
(zkCallback-4502-thread-1-processing-n:127.0.0.1:57105_solr)
[n:127.0.0.1:57105_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3684665 INFO
(zkCallback-4500-thread-1-processing-n:127.0.0.1:53244_solr)
[n:127.0.0.1:53244_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3684672 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3684672 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3684672 INFO (qtp167393648-56371) [n:127.0.0.1:35293_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3684678 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@446c4372[addReplicaColl_shard1_replica1] main]
[junit4] 2> 3684680 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 3684681 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 3684681 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@655b13ba[addReplicaColl_shard2_replica2] main]
[junit4] 2> 3684681 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3684681 INFO (qtp990896924-56391) [n:127.0.0.1:38931_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1593999627209670656
[junit4] 2> 3684682 INFO
(searcherExecutor-8704-thread-1-processing-n:127.0.0.1:38931_solr
x:addReplicaColl_shard1_replica1 s:shard1 c:addReplicaColl)
[n:127.0.0.1:38931_solr c:addReplicaColl s:shard1
x:addReplicaColl_shard1_replica1] o.a.s.c.SolrCore
[addReplicaColl_shard1_replica1] Registered new searcher
Searcher@446c4372[addReplicaColl_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3684683 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 3684683 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 3684683 INFO (qtp1299584871-56401) [n:127.0.0.1:57105_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.h.Replicati
[...truncated too long message...]
entDeleteAndCreateCollectionTest, OverseerTaskQueueTest, TestSort,
CloudMLTQParserTest, CoreSorterTest, TestShardHandlerFactory, TestConfigSets,
AsyncCallRequestStatusResponseTest, CoreAdminRequestStatusTest, RuleEngineTest,
PKIAuthenticationIntegrationTest, TestTrieFacet,
TestSolrQueryParserDefaultOperatorResource, LeaderFailureAfterFreshStartTest,
TestPerFieldSimilarityWithDefaultOverride, TestFieldCacheSort,
OpenExchangeRatesOrgProviderTest, TestObjectReleaseTracker,
ShowFileRequestHandlerTest, HdfsBasicDistributedZkTest,
PreAnalyzedFieldManagedSchemaCloudTest, TestSegmentSorting,
PreAnalyzedFieldTest, ParsingFieldUpdateProcessorsTest, NoCacheHeaderTest,
TestChildDocTransformer, BlockJoinFacetDistribTest, SolrMetricsIntegrationTest,
TestMergePolicyConfig, StatelessScriptUpdateProcessorFactoryTest,
ZkStateReaderTest, TestNumericTerms64, TestConfigOverlay, CursorMarkTest,
TestFieldCollectionResource, LegacyCloudClusterPropTest,
SolrCoreMetricManagerTest, DistributedVersionInfoTest, TestJsonFacetRefinement,
DebugComponentTest, UnloadDistributedZkTest, OverseerTest,
LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest,
TestHashPartitioner, TermVectorComponentDistributedTest, TestReload,
TestRangeQuery, HighlighterConfigTest, TestQuerySenderListener,
ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest,
TestStressRecovery, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest,
TestIBSimilarityFactory, TestFastWriter, TimeZoneUtilsTest, ScriptEngineTest,
ChaosMonkeyNothingIsSafeTest, CdcrReplicationDistributedZkTest,
CdcrReplicationHandlerTest, ConfigSetsAPITest, CreateCollectionCleanupTest,
DistribCursorPagingTest, ForceLeaderTest, SSLMigrationTest,
SaslZkACLProviderTest, ShardSplitTest, TestCloudPivotFacet,
TestCloudPseudoReturnFields, TestCloudRecovery, TestCollectionAPI,
TestCryptoKeys, TestLeaderElectionWithEmptyReplica, TestLeaderElectionZkExpiry,
TestLockTree, TestMiniSolrCloudCluster, TestRandomRequestDistribution,
TestRebalanceLeaders, TestReplicaProperties, TestRequestForwarding,
TestSSLRandomization, TestSizeLimitedDistributedMap,
TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud,
TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest,
HdfsBasicDistributedZk2Test, HdfsCollectionsAPIDistributedZkTest,
TestClusterStateMutator, RulesTest, HdfsDirectoryFactoryTest,
TestConfigSetImmutable, TestConfigSetProperties, TestCustomStream,
TestImplicitCoreProperties, TestNRTOpen, TestSolrConfigHandler,
TestHdfsBackupRestoreCore, CoreAdminCreateDiscoverTest,
CoreMergeIndexesAdminHandlerTest, InfoHandlerTest, SecurityConfHandlerTest,
StatsReloadRaceTest, TestCollectionAPIs, TestCoreAdminApis,
DistributedExpandComponentTest, DistributedFacetPivotSmallTest,
DistributedSuggestComponentTest, JavabinLoaderTest, HighlighterMaxOffsetTest,
TestSlowCompositeReaderWrapper, WrapperMergePolicyFactoryTest,
CheckHdfsIndexTest, TestCloudSchemaless, TestUseDocValuesAsStored2,
RankQueryTest, SortSpecParsingTest, TestCollapseQParserPlugin,
TestComplexPhraseLeadingWildcard, TestFieldSortValues, TestFilteredDocIdSet,
TestHashQParserPlugin, TestNoOpRegenerator, TestRandomCollapseQParserPlugin,
TestSmileRequest, TestStandardQParsers, TestXmlQParser, TestXmlQParserPlugin,
TestJsonFacets, TestAuthorizationFramework, TestFieldCacheReopen,
TestFieldCacheSortRandom, TestLegacyFieldCache, TestNumericTerms32,
TestUninvertingReader, AddBlockUpdateTest, AnalysisErrorHandlingTest,
CdcrUpdateLogTest, TestInPlaceUpdatesDistrib]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestInPlaceUpdatesDistrib -Dtests.seed=78CE862CA70D20DD
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/test-data/enwiki.random.lines.txt
-Dtests.locale=es-CU -Dtests.timezone=Etc/Zulu -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J2 | TestInPlaceUpdatesDistrib (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE
scope at org.apache.solr.update.TestInPlaceUpdatesDistrib:
[junit4] > 1) Thread[id=63443, name=searcherExecutor-10694-thread-1,
state=WAITING, group=TGRP-TestInPlaceUpdatesDistrib]
[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:1074)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 2) Thread[id=63409, name=searcherExecutor-10683-thread-1,
state=WAITING, group=TGRP-TestInPlaceUpdatesDistrib]
[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:1074)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=63443, name=searcherExecutor-10694-thread-1,
state=WAITING, group=TGRP-TestInPlaceUpdatesDistrib]
[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:1074)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > 2) Thread[id=63409, name=searcherExecutor-10683-thread-1,
state=WAITING, group=TGRP-TestInPlaceUpdatesDistrib]
[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:1074)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([78CE862CA70D20DD]:0)
[junit4] Completed [714/714 (3!)] on J2 in 1465.25s, 1 test, 3 errors <<<
FAILURES!
[...truncated 1 lines...]
[junit4] JVM J2: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/temp/junit4-J2-20180304_084016_6928344625705321710958.sysout
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] Dumping heap to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/heapdumps/java_pid7833.hprof
...
[junit4] Heap dump file created [660867319 bytes in 3.026 secs]
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J2: stderr was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/solr/build/solr-core/test/temp/junit4-J2-20180304_084016_692805811283229828314.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4]
[junit4] Exception: java.lang.OutOfMemoryError thrown from the
UncaughtExceptionHandler in thread "SessionTracker"
[junit4] <<< JVM J2: EOF ----
[...truncated 8104 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/build.xml:783:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.6/checkout/build.xml:727:
Some of the tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid7833.hprof
Total time: 277 minutes 55 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
