lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-5.5 - Build # 5 - Still Failing
Date Thu, 28 Apr 2016 02:38:13 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.5/5/

10 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Captured an uncaught exception in thread: Thread[id=5532, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5532, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
	... 7 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Captured an uncaught exception in thread: Thread[id=5533, name=collection5, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5533, name=collection5, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
	... 7 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Captured an uncaught exception in thread: Thread[id=5531, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5531, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
	... 7 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Captured an uncaught exception in thread: Thread[id=5528, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5528, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:991)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
	... 5 more


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest

Error Message:
Captured an uncaught exception in thread: Thread[id=5530, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5530, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
	... 7 more


FAILED:  org.apache.solr.cloud.SyncSliceTest.test

Error Message:
timeout waiting to see all nodes active

Stack Trace:
java.lang.AssertionError: timeout waiting to see all nodes active
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0:43CC88F73C9F6D08]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.SyncSliceTest.waitTillAllNodesActive(SyncSliceTest.java:238)
	at org.apache.solr.cloud.SyncSliceTest.test(SyncSliceTest.java:166)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
ObjectTracker found 2 object(s) that were not released!!! [NRTCachingDirectory, NRTCachingDirectory]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [NRTCachingDirectory, NRTCachingDirectory]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNull(Assert.java:551)
	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:228)
	at sun.reflect.GeneratedMethodAccessor21.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsChaosMonkeySafeLeaderTest

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [HdfsTransactionLog]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [HdfsTransactionLog]
	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNull(Assert.java:551)
	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:228)
	at sun.reflect.GeneratedMethodAccessor77.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11536 lines...]
   [junit4] Suite: org.apache.solr.cloud.SyncSliceTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/init-core-data-001
   [junit4]   2> 1378198 INFO  (SUITE-SyncSliceTest-seed#[CB98B72D926300F0]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1378198 INFO  (SUITE-SyncSliceTest-seed#[CB98B72D926300F0]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /u_/u
   [junit4]   2> 1378208 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1378208 INFO  (Thread-54527) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1378210 INFO  (Thread-54527) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1378310 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkTestServer start zk server on port:55465
   [junit4]   2> 1378310 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1378311 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1378317 INFO  (zkCallback-748-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7d913bb7 name:ZooKeeperConnection Watcher:127.0.0.1:55465 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1378317 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1378318 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1378318 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1378322 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1378323 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1378325 INFO  (zkCallback-749-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5471d5f3 name:ZooKeeperConnection Watcher:127.0.0.1:55465/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1378325 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1378325 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1378325 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1378328 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1378329 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1378329 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1378330 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 1378330 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1378333 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 1378333 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1378335 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1378335 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1378336 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 1378336 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1378338 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 1378338 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1378339 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 1378339 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1378341 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1378341 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1378343 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1378343 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1378344 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1378344 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1378346 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1378346 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1378347 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 1378347 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1378404 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1
   [junit4]   2> 1378405 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1378406 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5fdb9f91{/u_/u,null,AVAILABLE}
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.ServerConnector Started ServerConnector@7fb9f4c5{HTTP/1.1}{127.0.0.1:43900}
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.Server Started @1380341ms
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=43900, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/tempDir-001/control/data, hostContext=/u_/u, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores}
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001'
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1378409 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1378410 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1378413 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1378413 INFO  (zkCallback-750-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@54b66878 name:ZooKeeperConnection Watcher:127.0.0.1:55465/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1378413 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1378413 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1378421 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1378421 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/solr.xml
   [junit4]   2> 1378432 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores
   [junit4]   2> 1378432 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer New CoreContainer 1532874741
   [junit4]   2> 1378432 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001]
   [junit4]   2> 1378432 WARN  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/lib
   [junit4]   2> 1378432 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1378433 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55465/solr
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1378434 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1378436 INFO  (zkCallback-753-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5548e681 name:ZooKeeperConnection Watcher:127.0.0.1:55465 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1378437 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1378438 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1378442 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$6@4af07264
   [junit4]   2> 1378442 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1378443 INFO  (zkCallback-754-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@580491d4 name:ZooKeeperConnection Watcher:127.0.0.1:55465/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1378443 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1378444 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1378446 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 1378448 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 1378449 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 1378452 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 1378454 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1378455 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1378456 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1378457 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1378458 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43900_u_%2Fu
   [junit4]   2> 1378458 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:43900_u_%2Fu
   [junit4]   2> 1378460 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1378461 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 1378462 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1378463 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000
   [junit4]   2> 1378463 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43900_u_%2Fu
   [junit4]   2> 1378463 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 1378464 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer Overseer (id=95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) starting
   [junit4]   2> 1378466 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 1378473 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1378473 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1378475 INFO  (OverseerCollectionConfigSetProcessor-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
   [junit4]   2> 1378476 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1378486 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1378486 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1378486 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores
   [junit4]   2> 1378487 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {schema=schema.xml, dataDir=data/, config=solrconfig.xml, configSetProperties=configsetprops.json, loadOnStartup=true, transient=false, shard=, coreNodeName=, name=collection1, collection=control_collection}
   [junit4]   2> 1378487 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1
   [junit4]   2> 1378487 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1378487 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0
   [junit4]   2> 1378488 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1378488 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1378488 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
   [junit4]   2> 1378490 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController Collection control_collection not visible yet, but flagging it so a watch is registered when it becomes visible
   [junit4]   2> 1378490 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [control_collection]
   [junit4]   2> 1378491 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "state":"down",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:43900/u_/u",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "node_name":"127.0.0.1:43900_u_%2Fu",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":null} current state version: 0
   [junit4]   2> 1378491 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 1378491 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "state":"down",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:43900/u_/u",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "node_name":"127.0.0.1:43900_u_%2Fu",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":null}
   [junit4]   2> 1378492 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection
   [junit4]   2> 1378492 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1378492 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController look for our core node name
   [junit4]   2> 1378495 INFO  (zkCallback-754-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1379493 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1379493 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 1379493 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 1379493 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection]
   [junit4]   2> 1379494 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1379494 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1'
   [junit4]   2> 1379494 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1379494 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1379495 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 
   [junit4]   2> 1379500 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1379510 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 1379529 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1379534 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1379714 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1379719 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1379721 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1379728 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1379730 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1379732 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1379732 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1379734 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0
   [junit4]   2> 1379734 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection   x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
   [junit4]   2> 1379734 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1379734 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/]
   [junit4]   2> 1379734 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@23cf5b45
   [junit4]   2> 1379735 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data
   [junit4]   2> 1379735 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/index/
   [junit4]   2> 1379735 WARN  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1379736 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/index
   [junit4]   2> 1379736 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=48.4873046875, floorSegmentMB=1.498046875, forceMergeDeletesPctAllowed=21.136134229889233, segmentsPerTier=19.0, maxCFSSegmentSizeMB=0.93359375, noCFSRatio=0.36181539462756385
   [junit4]   2> 1379737 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@fc15060 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c83d6b4),segFN=segments_1,generation=1}
   [junit4]   2> 1379737 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1379739 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1379739 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1379739 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1379739 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1379739 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1379740 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1379740 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1379740 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1379740 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1379740 WARN  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1379742 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1379742 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1379743 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1379744 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1379746 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /schema,/update/json,/admin/threads,/admin/mbeans,/admin/file,/admin/system,/config,/update/json/docs,/admin/plugins,/dump,/update,/admin/segments,/admin/logging,/get,/admin/ping,/replication,standard,/admin/luke,/admin/properties,/update/csv
   [junit4]   2> 1379747 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1379747 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/
   [junit4]   2> 1379747 WARN  (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
   [junit4]   2> 1379747 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1379749 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=0.8251953125, floorSegmentMB=0.978515625, forceMergeDeletesPctAllowed=9.416446882940775, segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@fc15060 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c83d6b4),segFN=segments_1,generation=1}
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1379750 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6286eb0[collection1] main
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection]
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1379751 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
   [junit4]   2> 1379752 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1532813256150745088
   [junit4]   2> 1379753 INFO  (searcherExecutor-4053-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6286eb0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1379754 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1532813256150745088
   [junit4]   2> 1379754 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1379755 INFO  (coreLoadExecutor-4052-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1379755 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:43900/u_/u collection:control_collection shard:shard1
   [junit4]   2> 1379756 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 1379770 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/95800828408627204-core_node1-n_0000000000
   [junit4]   2> 1379772 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=10000
   [junit4]   2> 1379775 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1379775 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1379775 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:43900/u_/u/collection1/
   [junit4]   2> 1379775 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1379775 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:43900/u_/u/collection1/ has no replicas
   [junit4]   2> 1379775 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection"} current state version: 1
   [junit4]   2> 1379776 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 1379777 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/95800828408627204-core_node1-n_0000000000
   [junit4]   2> 1379779 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:43900/u_/u/collection1/ shard1
   [junit4]   2> 1379780 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "base_url":"http://127.0.0.1:43900/u_/u",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 1379882 INFO  (zkCallback-754-thread-1-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1379930 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:43900/u_/u/collection1/ and leader is http://127.0.0.1:43900/u_/u/collection1/
   [junit4]   2> 1379930 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:43900/u_/u
   [junit4]   2> 1379930 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1379930 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active
   [junit4]   2> 1379930 INFO  (coreZkRegister-4046-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1) [n:127.0.0.1:43900_u_%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
   [junit4]   2> 1379934 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "state":"active",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:43900/u_/u",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "node_name":"127.0.0.1:43900_u_%2Fu",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":"shard1"} current state version: 2
   [junit4]   2> 1379934 INFO  (OverseerStateUpdate-95800828408627204-127.0.0.1:43900_u_%2Fu-n_0000000000) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "state":"active",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:43900/u_/u",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "node_name":"127.0.0.1:43900_u_%2Fu",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "shard":"shard1"}
   [junit4]   2> 1379989 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1379989 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1379991 INFO  (zkCallback-756-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@79e46e1c name:ZooKeeperConnection Watcher:127.0.0.1:55465/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1379991 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1379991 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1379991 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1380008 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 1380036 INFO  (zkCallback-756-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1380037 INFO  (zkCallback-754-thread-2-processing-n:127.0.0.1:43900_u_%2Fu) [n:127.0.0.1:43900_u_%2Fu    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1380072 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/cores/collection1
   [junit4]   2> 1380072 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001
   [junit4]   2> 1380073 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1380074 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@518d32be{/u_/u,null,AVAILABLE}
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.ServerConnector Started ServerConnector@18f9f4d4{HTTP/1.1}{127.0.0.1:58329}
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.e.j.s.Server Started @1382007ms
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=58329, solrconfig=solrconfig.xml, hostContext=/u_/u, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/cores, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/tempDir-001/jetty1}
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001'
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1380075 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1380076 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1380078 INFO  (zkCallback-757-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7b688c9c name:ZooKeeperConnection Watcher:127.0.0.1:55465/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1380078 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1380078 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1380080 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1380080 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/solr.xml
   [junit4]   2> 1380089 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/cores
   [junit4]   2> 1380089 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer New CoreContainer 682217042
   [junit4]   2> 1380089 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001]
   [junit4]   2> 1380089 WARN  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.SyncSliceTest_CB98B72D926300F0-001/shard-1-001/lib
   [junit4]   2> 1380090 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1380090 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55465/solr
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1380091 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1380092 INFO  (zkCallback-760-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@59fea41 name:ZooKeeperConnection Watcher:127.0.0.1:55465 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1380093 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1380094 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1380096 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:58329_u_%2Fu    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$6@2d2ba522
   [junit4]   2> 1380096 INFO  (TEST-SyncSliceTest.test-seed#[CB98B72D926300F0]) [n:127.0.0.1:58329_u_%2Fu    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1380098 INFO  (zkCallback-761-thread-1-processing-n:127.0.0.1:58329_u_%2Fu) [n:127.0.0.1:58329_u_%2Fu    ] o.a.s.c.c.ConnectionManager Watcher org.apa

[...truncated too long message...]

ttpSolrClient.java:372)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    > 	... 7 moreThrowable #4: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5531, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
   [junit4]    > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    > 	... 7 moreThrowable #5: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5528, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:991)
   [junit4]    > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    > 	... 5 moreThrowable #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5530, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CB98B72D926300F0]:0)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:38628, http://127.0.0.1:60704, http://127.0.0.1:44277, http://127.0.0.1:57002, http://127.0.0.1:54905]
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
   [junit4]    > 	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)
   [junit4]    > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:57002: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr-
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    > 	... 7 more
   [junit4] Completed [525/572 (4!)] on J1 in 7223.99s, 1 test, 7 errors <<< FAILURES!

[...truncated 139 lines...]
   [junit4] JVM J1: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/temp/junit4-J1-20160428_002732_482.sysout
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
   [junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/heapdumps/java_pid26524.hprof ...
   [junit4] Heap dump file created [671897352 bytes in 7.523 secs]
   [junit4] <<< JVM J1: EOF ----

[...truncated 14 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:757: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:694: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/common-build.xml:534: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1477: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1033: There were test failures: 572 suites (7 ignored), 2290 tests, 8 suite-level errors, 1 error, 1 failure, 147 ignored (17 assumptions) [seed: CB98B72D926300F0]

Total time: 233 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any




Mime
View raw message