lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk1.8.0) - Build # 3835 - Still Unstable!
Date Wed, 15 Feb 2017 20:09:38 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3835/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC

4 tests failed.
FAILED:  org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter

Error Message:
Collection not found: withShardField

Stack Trace:
org.apache.solr.common.SolrException: Collection not found: withShardField
	at __randomizedtesting.SeedInfo.seed([723A1655EA4FAD35:276AFEC746B662C5]:0)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.getCollectionNames(CloudSolrClient.java:1376)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1072)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1042)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
	at org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:232)
	at org.apache.solr.cloud.CustomCollectionTest.testRouteFieldForImplicitRouter(CustomCollectionTest.java:141)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.PeerSyncReplicationTest.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([723A1655EA4FAD35:FA6E298F44B3C0CD]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.PeerSyncReplicationTest.waitTillNodesActive(PeerSyncReplicationTest.java:326)
	at org.apache.solr.cloud.PeerSyncReplicationTest.bringUpDeadNodeAndEnsureNoReplication(PeerSyncReplicationTest.java:277)
	at org.apache.solr.cloud.PeerSyncReplicationTest.forceNodeFailureAndDoPeerSync(PeerSyncReplicationTest.java:259)
	at org.apache.solr.cloud.PeerSyncReplicationTest.test(PeerSyncReplicationTest.java:138)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)


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

Error Message:
Error from server at http://127.0.0.1:64036/solr: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 404 </title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem accessing /solr/admin/collections. Reason: <pre>    Can not find: /solr/admin/collections</pre></p> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/> </body> </html> 

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:64036/solr: Expected mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /solr/admin/collections. Reason:
<pre>    Can not find: /solr/admin/collections</pre></p>
<hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/>
</body>
</html>

	at __randomizedtesting.SeedInfo.seed([723A1655EA4FAD35]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:595)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:439)
	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:391)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1358)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1109)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1042)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:177)
	at org.apache.solr.cloud.TestTolerantUpdateProcessorRandomCloud.createMiniSolrCloudCluster(TestTolerantUpdateProcessorRandomCloud.java:111)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:847)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.TestMiniSolrCloudCluster.testCollectionCreateSearchDelete

Error Message:
Could not find collection:testcollection

Stack Trace:
java.lang.AssertionError: Could not find collection:testcollection
	at __randomizedtesting.SeedInfo.seed([723A1655EA4FAD35:D1C0B8F06DA74790]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNotNull(Assert.java:526)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:159)
	at org.apache.solr.cloud.TestMiniSolrCloudCluster.testCollectionCreateSearchDelete(TestMiniSolrCloudCluster.java:165)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12387 lines...]
   [junit4] Suite: org.apache.solr.cloud.CustomCollectionTest
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/init-core-data-001
   [junit4]   2> 2507131 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 2507135 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 2507136 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001
   [junit4]   2> 2507137 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2507137 INFO  (Thread-3873) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2507137 INFO  (Thread-3873) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 2507237 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:61497
   [junit4]   2> 2507263 INFO  (jetty-launcher-3237-thread-2) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2507263 INFO  (jetty-launcher-3237-thread-1) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2507263 INFO  (jetty-launcher-3237-thread-3) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2507264 INFO  (jetty-launcher-3237-thread-4) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2507265 INFO  (jetty-launcher-3237-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@68d6dfab{/solr,null,AVAILABLE}
   [junit4]   2> 2507267 INFO  (jetty-launcher-3237-thread-3) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@11fb940f{/solr,null,AVAILABLE}
   [junit4]   2> 2507268 INFO  (jetty-launcher-3237-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@6da15cac{SSL,[ssl, http/1.1]}{127.0.0.1:61499}
   [junit4]   2> 2507268 INFO  (jetty-launcher-3237-thread-2) [    ] o.e.j.s.Server Started @2512114ms
   [junit4]   2> 2507268 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61499}
   [junit4]   2> 2507268 ERROR (jetty-launcher-3237-thread-2) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2507268 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 2507269 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2507269 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2507269 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-02-15T19:21:42.372Z
   [junit4]   2> 2507271 INFO  (jetty-launcher-3237-thread-4) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7685c36a{/solr,null,AVAILABLE}
   [junit4]   2> 2507271 INFO  (jetty-launcher-3237-thread-3) [    ] o.e.j.s.AbstractConnector Started ServerConnector@6475b9ee{SSL,[ssl, http/1.1]}{127.0.0.1:61500}
   [junit4]   2> 2507271 INFO  (jetty-launcher-3237-thread-3) [    ] o.e.j.s.Server Started @2512118ms
   [junit4]   2> 2507271 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61500}
   [junit4]   2> 2507272 ERROR (jetty-launcher-3237-thread-3) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-4) [    ] o.e.j.s.AbstractConnector Started ServerConnector@684f9672{SSL,[ssl, http/1.1]}{127.0.0.1:61502}
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-4) [    ] o.e.j.s.Server Started @2512118ms
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61502}
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 2507272 ERROR (jetty-launcher-3237-thread-4) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-02-15T19:21:42.375Z
   [junit4]   2> 2507272 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 2507273 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2507273 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2507273 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-02-15T19:21:42.376Z
   [junit4]   2> 2507273 INFO  (jetty-launcher-3237-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5e5f1b3a{/solr,null,AVAILABLE}
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@7d64d577{SSL,[ssl, http/1.1]}{127.0.0.1:61503}
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.e.j.s.Server Started @2512120ms
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61503}
   [junit4]   2> 2507274 ERROR (jetty-launcher-3237-thread-1) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2507274 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2507275 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-02-15T19:21:42.377Z
   [junit4]   2> 2507276 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2507279 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2507279 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2507280 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2507303 INFO  (jetty-launcher-3237-thread-4) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61497/solr
   [junit4]   2> 2507304 INFO  (jetty-launcher-3237-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61497/solr
   [junit4]   2> 2507307 INFO  (jetty-launcher-3237-thread-3) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61497/solr
   [junit4]   2> 2507348 INFO  (jetty-launcher-3237-thread-4) [n:127.0.0.1:61502_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2507348 INFO  (jetty-launcher-3237-thread-1) [n:127.0.0.1:61503_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2507349 INFO  (jetty-launcher-3237-thread-1) [n:127.0.0.1:61503_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:61503_solr
   [junit4]   2> 2507349 INFO  (jetty-launcher-3237-thread-3) [n:127.0.0.1:61500_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2507350 INFO  (jetty-launcher-3237-thread-4) [n:127.0.0.1:61502_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61502_solr
   [junit4]   2> 2507351 INFO  (jetty-launcher-3237-thread-1) [n:127.0.0.1:61503_solr    ] o.a.s.c.Overseer Overseer (id=97464254610997257-127.0.0.1:61503_solr-n_0000000000) starting
   [junit4]   2> 2507351 INFO  (jetty-launcher-3237-thread-3) [n:127.0.0.1:61500_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61500_solr
   [junit4]   2> 2507354 INFO  (zkCallback-3254-thread-1-processing-n:127.0.0.1:61500_solr) [n:127.0.0.1:61500_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2507354 INFO  (zkCallback-3253-thread-1-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2507354 INFO  (zkCallback-3251-thread-1-processing-n:127.0.0.1:61502_solr) [n:127.0.0.1:61502_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 2507354 INFO  (jetty-launcher-3237-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61497/solr
   [junit4]   2> 2507356 INFO  (zkCallback-3253-thread-1-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2507357 INFO  (zkCallback-3254-thread-1-processing-n:127.0.0.1:61500_solr) [n:127.0.0.1:61500_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2507357 INFO  (zkCallback-3251-thread-1-processing-n:127.0.0.1:61502_solr) [n:127.0.0.1:61502_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 2507367 INFO  (jetty-launcher-3237-thread-1) [n:127.0.0.1:61503_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61503_solr
   [junit4]   2> 2507371 INFO  (zkCallback-3254-thread-1-processing-n:127.0.0.1:61500_solr) [n:127.0.0.1:61500_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2507371 INFO  (zkCallback-3251-thread-1-processing-n:127.0.0.1:61502_solr) [n:127.0.0.1:61502_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2507371 INFO  (zkCallback-3253-thread-1-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 2507396 INFO  (jetty-launcher-3237-thread-2) [n:127.0.0.1:61499_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2507400 INFO  (jetty-launcher-3237-thread-2) [n:127.0.0.1:61499_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2507403 INFO  (jetty-launcher-3237-thread-2) [n:127.0.0.1:61499_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:61499_solr
   [junit4]   2> 2507407 INFO  (zkCallback-3253-thread-2-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2507407 INFO  (zkCallback-3251-thread-1-processing-n:127.0.0.1:61502_solr) [n:127.0.0.1:61502_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2507407 INFO  (zkCallback-3254-thread-1-processing-n:127.0.0.1:61500_solr) [n:127.0.0.1:61500_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2507409 INFO  (zkCallback-3261-thread-1-processing-n:127.0.0.1:61499_solr) [n:127.0.0.1:61499_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 2507485 INFO  (jetty-launcher-3237-thread-2) [n:127.0.0.1:61499_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/.
   [junit4]   2> 2507487 INFO  (jetty-launcher-3237-thread-1) [n:127.0.0.1:61503_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/.
   [junit4]   2> 2507504 INFO  (jetty-launcher-3237-thread-4) [n:127.0.0.1:61502_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/.
   [junit4]   2> 2507701 INFO  (jetty-launcher-3237-thread-3) [n:127.0.0.1:61500_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/.
   [junit4]   2> 2509475 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2509477 INFO  (SUITE-CustomCollectionTest-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61497/solr ready
   [junit4]   2> 2509517 INFO  (TEST-CustomCollectionTest.testCustomCollectionsAPI-seed#[723A1655EA4FAD35]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCustomCollectionsAPI
   [junit4]   2> 2509519 INFO  (TEST-CustomCollectionTest.testCustomCollectionsAPI-seed#[723A1655EA4FAD35]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2509542 INFO  (qtp124828377-18572) [n:127.0.0.1:61502_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params shards=a,b,c&replicationFactor=5&collection.configName=conf&maxShardsPerNode=6&name=implicitcoll&router.name=implicit&action=CREATE&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2509545 INFO  (OverseerThreadFactory-8825-thread-1-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.CreateCollectionCmd Create collection implicitcoll
   [junit4]   2> 2509546 WARN  (OverseerThreadFactory-8825-thread-1-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.CreateCollectionCmd Specified replicationFactor of 5 on collection implicitcoll is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(4). It's unusual to run two replica of the same slice on the same Solr-instance.
   [junit4]   2> 2509719 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_a_replica1&action=CREATE&numShards=3&collection=implicitcoll&shard=a&wt=javabin&version=2
   [junit4]   2> 2509756 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_a_replica2&action=CREATE&numShards=3&collection=implicitcoll&shard=a&wt=javabin&version=2
   [junit4]   2> 2509757 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_c_replica4&action=CREATE&numShards=3&collection=implicitcoll&shard=c&wt=javabin&version=2
   [junit4]   2> 2509758 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_b_replica1&action=CREATE&numShards=3&collection=implicitcoll&shard=b&wt=javabin&version=2
   [junit4]   2> 2509758 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_b_replica5&action=CREATE&numShards=3&collection=implicitcoll&shard=b&wt=javabin&version=2
   [junit4]   2> 2509782 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_c_replica1&action=CREATE&numShards=3&collection=implicitcoll&shard=c&wt=javabin&version=2
   [junit4]   2> 2509783 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_a_replica5&action=CREATE&numShards=3&collection=implicitcoll&shard=a&wt=javabin&version=2
   [junit4]   2> 2509787 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_b_replica3&action=CREATE&numShards=3&collection=implicitcoll&shard=b&wt=javabin&version=2
   [junit4]   2> 2509788 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_a_replica3&action=CREATE&numShards=3&collection=implicitcoll&shard=a&wt=javabin&version=2
   [junit4]   2> 2509789 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_c_replica5&action=CREATE&numShards=3&collection=implicitcoll&shard=c&wt=javabin&version=2
   [junit4]   2> 2509793 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_b_replica4&action=CREATE&numShards=3&collection=implicitcoll&shard=b&wt=javabin&version=2
   [junit4]   2> 2509793 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_c_replica3&action=CREATE&numShards=3&collection=implicitcoll&shard=c&wt=javabin&version=2
   [junit4]   2> 2509796 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_a_replica4&action=CREATE&numShards=3&collection=implicitcoll&shard=a&wt=javabin&version=2
   [junit4]   2> 2509799 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_c_replica2&action=CREATE&numShards=3&collection=implicitcoll&shard=c&wt=javabin&version=2
   [junit4]   2> 2509800 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=implicitcoll_b_replica2&action=CREATE&numShards=3&collection=implicitcoll&shard=b&wt=javabin&version=2
   [junit4]   2> 2509929 INFO  (zkCallback-3251-thread-1-processing-n:127.0.0.1:61502_solr) [n:127.0.0.1:61502_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/implicitcoll/state.json] for collection [implicitcoll] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2509929 INFO  (zkCallback-3261-thread-1-processing-n:127.0.0.1:61499_solr) [n:127.0.0.1:61499_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/implicitcoll/state.json] for collection [implicitcoll] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2509929 INFO  (zkCallback-3254-thread-1-processing-n:127.0.0.1:61500_solr) [n:127.0.0.1:61500_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/implicitcoll/state.json] for collection [implicitcoll] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2509929 INFO  (zkCallback-3253-thread-3-processing-n:127.0.0.1:61503_solr) [n:127.0.0.1:61503_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/implicitcoll/state.json] for collection [implicitcoll] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2510792 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510792 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510794 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510803 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510812 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510825 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.s.IndexSchema [implicitcoll_a_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2510828 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.s.IndexSchema [implicitcoll_b_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2510838 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510842 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510858 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.s.IndexSchema [implicitcoll_c_replica4] Schema name=cloud-dynamic
   [junit4]   2> 2510859 WARN  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.s.IndexSchema [implicitcoll_a_replica1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2510860 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2510863 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510864 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.s.IndexSchema [implicitcoll_a_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2510878 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510878 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_a_replica1' using configuration from collection implicitcoll
   [junit4]   2> 2510879 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.c.SolrCore [[implicitcoll_a_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/implicitcoll_a_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/./implicitcoll_a_replica1/data/]
   [junit4]   2> 2510888 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510888 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510892 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.s.IndexSchema [implicitcoll_b_replica4] Schema name=cloud-dynamic
   [junit4]   2> 2510905 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.s.IndexSchema [implicitcoll_a_replica5] Schema name=cloud-dynamic
   [junit4]   2> 2510927 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510928 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510936 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510940 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 2510962 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.s.IndexSchema [implicitcoll_a_replica3] Schema name=cloud-dynamic
   [junit4]   2> 2510964 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.s.IndexSchema [implicitcoll_b_replica5] Schema name=cloud-dynamic
   [junit4]   2> 2510965 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.s.IndexSchema [implicitcoll_b_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2510966 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.s.IndexSchema [implicitcoll_c_replica1] Schema name=cloud-dynamic
   [junit4]   2> 2510971 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.s.IndexSchema [implicitcoll_c_replica2] Schema name=cloud-dynamic
   [junit4]   2> 2510984 WARN  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.s.IndexSchema [implicitcoll_a_replica5] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2510985 WARN  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.s.IndexSchema [implicitcoll_a_replica2] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2510985 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2510985 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2510988 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_a_replica5' using configuration from collection implicitcoll
   [junit4]   2> 2510989 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.c.SolrCore [[implicitcoll_a_replica5] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/implicitcoll_a_replica5], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/./implicitcoll_a_replica5/data/]
   [junit4]   2> 2510988 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.s.IndexSchema [implicitcoll_c_replica3] Schema name=cloud-dynamic
   [junit4]   2> 2510987 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.s.IndexSchema [implicitcoll_a_replica4] Schema name=cloud-dynamic
   [junit4]   2> 2510986 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.s.IndexSchema [implicitcoll_c_replica5] Schema name=cloud-dynamic
   [junit4]   2> 2510986 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.s.IndexSchema [implicitcoll_b_replica3] Schema name=cloud-dynamic
   [junit4]   2> 2511020 WARN  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.s.IndexSchema [implicitcoll_c_replica4] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511021 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511045 WARN  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.s.IndexSchema [implicitcoll_b_replica2] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511046 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511058 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_a_replica2' using configuration from collection implicitcoll
   [junit4]   2> 2511069 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_b_replica2' using configuration from collection implicitcoll
   [junit4]   2> 2511069 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.c.SolrCore [[implicitcoll_b_replica2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/implicitcoll_b_replica2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/./implicitcoll_b_replica2/data/]
   [junit4]   2> 2511071 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_c_replica4' using configuration from collection implicitcoll
   [junit4]   2> 2511071 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.c.SolrCore [[implicitcoll_c_replica4] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/implicitcoll_c_replica4], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/./implicitcoll_c_replica4/data/]
   [junit4]   2> 2511075 WARN  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.s.IndexSchema [implicitcoll_c_replica1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511079 WARN  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.s.IndexSchema [implicitcoll_b_replica4] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511080 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511082 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_b_replica4' using configuration from collection implicitcoll
   [junit4]   2> 2511082 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.c.SolrCore [[implicitcoll_b_replica4] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/implicitcoll_b_replica4], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/./implicitcoll_b_replica4/data/]
   [junit4]   2> 2511083 WARN  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.s.IndexSchema [implicitcoll_c_replica2] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511084 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511085 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511085 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_c_replica2' using configuration from collection implicitcoll
   [junit4]   2> 2511085 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.c.SolrCore [[implicitcoll_c_replica2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/implicitcoll_c_replica2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/./implicitcoll_c_replica2/data/]
   [junit4]   2> 2511086 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_c_replica1' using configuration from collection implicitcoll
   [junit4]   2> 2511086 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.c.SolrCore [[implicitcoll_c_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/implicitcoll_c_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/./implicitcoll_c_replica1/data/]
   [junit4]   2> 2511088 WARN  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.s.IndexSchema [implicitcoll_b_replica5] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511089 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511090 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_b_replica5' using configuration from collection implicitcoll
   [junit4]   2> 2511090 WARN  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.s.IndexSchema [implicitcoll_b_replica3] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511090 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.c.SolrCore [[implicitcoll_b_replica5] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/implicitcoll_b_replica5], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/./implicitcoll_b_replica5/data/]
   [junit4]   2> 2511091 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511102 WARN  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.s.IndexSchema [implicitcoll_b_replica1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511102 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.c.SolrCore [[implicitcoll_a_replica2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/implicitcoll_a_replica2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/./implicitcoll_a_replica2/data/]
   [junit4]   2> 2511103 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511102 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_b_replica3' using configuration from collection implicitcoll
   [junit4]   2> 2511104 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.c.SolrCore [[implicitcoll_b_replica3] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/implicitcoll_b_replica3], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/./implicitcoll_b_replica3/data/]
   [junit4]   2> 2511104 WARN  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.s.IndexSchema [implicitcoll_a_replica3] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511105 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511106 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_b_replica1' using configuration from collection implicitcoll
   [junit4]   2> 2511106 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_a_replica3' using configuration from collection implicitcoll
   [junit4]   2> 2511106 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.c.SolrCore [[implicitcoll_b_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/implicitcoll_b_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node4/./implicitcoll_b_replica1/data/]
   [junit4]   2> 2511106 INFO  (qtp697516828-18553) [n:127.0.0.1:61500_solr c:implicitcoll s:a  x:implicitcoll_a_replica3] o.a.s.c.SolrCore [[implicitcoll_a_replica3] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/implicitcoll_a_replica3], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/./implicitcoll_a_replica3/data/]
   [junit4]   2> 2511112 WARN  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.s.IndexSchema [implicitcoll_c_replica5] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511113 WARN  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.s.IndexSchema [implicitcoll_c_replica3] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511113 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511113 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511114 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_c_replica3' using configuration from collection implicitcoll
   [junit4]   2> 2511115 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.c.SolrCore [[implicitcoll_c_replica3] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/implicitcoll_c_replica3], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node2/./implicitcoll_c_replica3/data/]
   [junit4]   2> 2511117 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_c_replica5' using configuration from collection implicitcoll
   [junit4]   2> 2511117 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.c.SolrCore [[implicitcoll_c_replica5] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/implicitcoll_c_replica5], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node3/./implicitcoll_c_replica5/data/]
   [junit4]   2> 2511121 WARN  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.s.IndexSchema [implicitcoll_a_replica4] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 2511121 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
   [junit4]   2> 2511123 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.c.CoreContainer Creating SolrCore 'implicitcoll_a_replica4' using configuration from collection implicitcoll
   [junit4]   2> 2511123 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.c.SolrCore [[implicitcoll_a_replica4] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/implicitcoll_a_replica4], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_723A1655EA4FAD35-001/tempDir-001/node1/./implicitcoll_a_replica4/data/]
   [junit4]   2> 2511276 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511276 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511278 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511278 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511282 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4a62b1ef[implicitcoll_a_replica1] main]
   [junit4]   2> 2511309 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511309 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511309 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511309 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511310 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511310 INFO  (qtp620300327-18543) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078148517888
   [junit4]   2> 2511310 INFO  (searcherExecutor-8834-thread-1-processing-n:127.0.0.1:61499_solr x:implicitcoll_a_replica1 s:a c:implicitcoll) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica1] o.a.s.c.SolrCore [implicitcoll_a_replica1] Registered new searcher Searcher@4a62b1ef[implicitcoll_a_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511310 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511310 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511312 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511312 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511312 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511312 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511321 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511321 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511323 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511323 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511325 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511325 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511327 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511327 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511332 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511332 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511334 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511334 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511341 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f308f0b[implicitcoll_c_replica2] main]
   [junit4]   2> 2511341 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.s.SolrIndexSearcher Opening [Searcher@6e63c497[implicitcoll_b_replica5] main]
   [junit4]   2> 2511346 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511349 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511349 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511349 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078189412352
   [junit4]   2> 2511349 INFO  (searcherExecutor-8840-thread-1-processing-n:127.0.0.1:61503_solr x:implicitcoll_c_replica2 s:c c:implicitcoll) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.c.SolrCore [implicitcoll_c_replica2] Registered new searcher Searcher@2f308f0b[implicitcoll_c_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511364 INFO  (qtp2094182752-18560) [n:127.0.0.1:61503_solr c:implicitcoll s:c  x:implicitcoll_c_replica2] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard c: total=5 found=1 timeoutin=9999ms
   [junit4]   2> 2511367 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511370 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511370 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511370 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.s.SolrIndexSearcher Opening [Searcher@3498ce8c[implicitcoll_a_replica5] main]
   [junit4]   2> 2511370 INFO  (qtp124828377-18576) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078211432448
   [junit4]   2> 2511370 INFO  (searcherExecutor-8842-thread-1-processing-n:127.0.0.1:61502_solr x:implicitcoll_b_replica5 s:b c:implicitcoll) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica5] o.a.s.c.SolrCore [implicitcoll_b_replica5] Registered new searcher Searcher@6e63c497[implicitcoll_b_replica5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511374 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d69f2b[implicitcoll_c_replica4] main]
   [junit4]   2> 2511378 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@406fb8b[implicitcoll_a_replica2] main]
   [junit4]   2> 2511381 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511381 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511383 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511383 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511385 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511385 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511389 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.s.SolrIndexSearcher Opening [Searcher@4fa06f8e[implicitcoll_b_replica4] main]
   [junit4]   2> 2511390 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511391 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511392 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7aa85a4b[implicitcoll_b_replica1] main]
   [junit4]   2> 2511395 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511395 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511397 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511397 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511397 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511397 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511397 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511397 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511398 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511398 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511399 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511399 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078241841152
   [junit4]   2> 2511399 INFO  (searcherExecutor-8835-thread-1-processing-n:127.0.0.1:61499_solr x:implicitcoll_a_replica5 s:a c:implicitcoll) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.c.SolrCore [implicitcoll_a_replica5] Registered new searcher Searcher@3498ce8c[implicitcoll_a_replica5] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511399 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078241841152
   [junit4]   2> 2511399 INFO  (searcherExecutor-8844-thread-1-processing-n:127.0.0.1:61502_solr x:implicitcoll_b_replica1 s:b c:implicitcoll) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.c.SolrCore [implicitcoll_b_replica1] Registered new searcher Searcher@7aa85a4b[implicitcoll_b_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511403 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511403 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511403 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511403 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511405 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511405 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511407 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511407 INFO  (qtp620300327-18545) [n:127.0.0.1:61499_solr c:implicitcoll s:a  x:implicitcoll_a_replica5] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard a: total=5 found=1 timeoutin=9999ms
   [junit4]   2> 2511407 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511408 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511408 INFO  (qtp620300327-18546) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078251278336
   [junit4]   2> 2511408 INFO  (searcherExecutor-8839-thread-1-processing-n:127.0.0.1:61499_solr x:implicitcoll_b_replica4 s:b c:implicitcoll) [n:127.0.0.1:61499_solr c:implicitcoll s:b  x:implicitcoll_b_replica4] o.a.s.c.SolrCore [implicitcoll_b_replica4] Registered new searcher Searcher@4fa06f8e[implicitcoll_b_replica4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511411 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511411 INFO  (qtp2094182752-18562) [n:127.0.0.1:61503_solr c:implicitcoll s:a  x:implicitcoll_a_replica4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511413 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511413 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511413 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.s.SolrIndexSearcher Opening [Searcher@520e5cb6[implicitcoll_c_replica3] main]
   [junit4]   2> 2511414 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511414 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511414 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511414 INFO  (searcherExecutor-8836-thread-1-processing-n:127.0.0.1:61502_solr x:implicitcoll_a_replica2 s:a c:implicitcoll) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.c.SolrCore [implicitcoll_a_replica2] Registered new searcher Searcher@406fb8b[implicitcoll_a_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511415 INFO  (qtp124828377-18573) [n:127.0.0.1:61502_solr c:implicitcoll s:a  x:implicitcoll_a_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078258618368
   [junit4]   2> 2511415 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511415 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511416 INFO  (searcherExecutor-8838-thread-1-processing-n:127.0.0.1:61502_solr x:implicitcoll_c_replica4 s:c c:implicitcoll) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.c.SolrCore [implicitcoll_c_replica4] Registered new searcher Searcher@6d69f2b[implicitcoll_c_replica4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511416 INFO  (qtp124828377-18575) [n:127.0.0.1:61502_solr c:implicitcoll s:c  x:implicitcoll_c_replica4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078259666944
   [junit4]   2> 2511419 INFO  (qtp124828377-18571) [n:127.0.0.1:61502_solr c:implicitcoll s:b  x:implicitcoll_b_replica1] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard b: total=5 found=2 timeoutin=9999ms
   [junit4]   2> 2511423 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.s.SolrIndexSearcher Opening [Searcher@36c8a5a9[implicitcoll_b_replica3] main]
   [junit4]   2> 2511424 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2511424 INFO  (qtp697516828-18555) [n:127.0.0.1:61500_solr c:implicitcoll s:b  x:implicitcoll_b_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2511424 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511425 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2511425 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2511425 INFO  (qtp2094182752-18561) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1559428078269104128
   [junit4]   2> 2511425 INFO  (searcherExecutor-8843-thread-1-processing-n:127.0.0.1:61503_solr x:implicitcoll_b_replica3 s:b c:implicitcoll) [n:127.0.0.1:61503_solr c:implicitcoll s:b  x:implicitcoll_b_replica3] o.a.s.c.SolrCore [implicitcoll_b_replica3] Registered new searcher Searcher@36c8a5a9[implicitcoll_b_replica3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2511427 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511427 INFO  (qtp697516828-18552) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica5] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511428 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2511428 INFO  (qtp697516828-18551) [n:127.0.0.1:61500_solr c:implicitcoll s:c  x:implicitcoll_c_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2511430 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2511430 INFO  (qtp620300327-18542) [n:127.0.0.1:61499_solr c:implicitcoll s:c  x:implicitcoll_c_replica3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4

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

> 	7	/solr/overseer/collection-queue-work
   [junit4]   2> 	2	/solr/overseer/queue
   [junit4]   2> 	2	/solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 3108648 INFO  (SUITE-TestTolerantUpdateProcessorRandomCloud-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 3108648 INFO  (SUITE-TestTolerantUpdateProcessorRandomCloud-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for all SolrIndexSearchers to be released
   [junit4]   2> 3108649 INFO  (SUITE-TestTolerantUpdateProcessorRandomCloud-seed#[723A1655EA4FAD35]-worker) [    ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=8352, maxDocsPerChunk=825, blockSize=5), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=8352, blockSize=5)), sim=RandomSimilarity(queryNorm=true): {}, locale=ro, timezone=America/Grenada
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=3,threads=1,free=67583928,total=529006592
   [junit4]   2> NOTE: All tests run in this JVM: [FullHLLTest, BigEndianAscendingWordDeserializerTest, CoreMergeIndexesAdminHandlerTest, TestSolrDeletionPolicy2, LeaderFailoverAfterPartitionTest, TestImplicitCoreProperties, TestLuceneMatchVersion, FullSolrCloudDistribCmdsTest, BufferStoreTest, BadCopyFieldTest, TestHdfsBackupRestoreCore, ClusterStateTest, DistributedIntervalFacetingTest, LukeRequestHandlerTest, ShowFileRequestHandlerTest, SuggesterWFSTTest, TestSSLRandomization, TestReversedWildcardFilterFactory, TestSolr4Spatial, ClassificationUpdateProcessorTest, LoggingHandlerTest, DeleteReplicaTest, DistribDocExpirationUpdateProcessorTest, TestCrossCoreJoin, IndexSchemaTest, TestSolrQueryParser, TestSmileRequest, TestPivotHelperCode, BasicDistributedZk2Test, TestRandomFaceting, FieldMutatingUpdateProcessorTest, TestScoreJoinQPScore, TestFieldCollectionResource, TestStressInPlaceUpdates, ReturnFieldsTest, SpellCheckComponentTest, CSVRequestHandlerTest, TestConfigSetsAPIZkFailure, SolrCmdDistributorTest, HighlighterConfigTest, UpdateRequestProcessorFactoryTest, TestCloudSchemaless, TestOrdValues, VMParamsZkACLAndCredentialsProvidersTest, TestNoOpRegenerator, TestConfig, ZkStateWriterTest, SolrJmxReporterTest, DefaultValueUpdateProcessorTest, SolrGangliaReporterTest, HttpSolrCallGetCoreTest, ParsingFieldUpdateProcessorsTest, TestPathTrie, TestRawResponseWriter, BadIndexSchemaTest, TestSimpleTrackingShardHandler, TestDynamicFieldCollectionResource, ShufflingReplicaListTransformerTest, TestFieldCacheWithThreads, TestInPlaceUpdatesDistrib, TestCodecSupport, DistributedQueueTest, TestExactStatsCache, TestCustomStream, AnalysisErrorHandlingTest, TestDownShardTolerantSearch, JavabinLoaderTest, HdfsNNFailoverTest, DocValuesMissingTest, TestClassicSimilarityFactory, RemoteQueryErrorTest, DistributedTermsComponentTest, TestUtils, TestCopyFieldCollectionResource, DistributedFacetPivotLongTailTest, TestSolrCoreSnapshots, JsonValidatorTest, SmileWriterTest, TestSolrCoreProperties, TestDocSet, TestSearchPerf, HdfsTlogReplayBufferedWhileIndexingTest, SpellingQueryConverterTest, UpdateLogTest, CloudMLTQParserTest, HLLUtilTest, HdfsDirectoryFactoryTest, TestWriterPerf, TestGeoJSONResponseWriter, ChaosMonkeySafeLeaderTest, DocExpirationUpdateProcessorFactoryTest, TestAuthenticationFramework, CursorMarkTest, TestFastWriter, CollectionsAPIDistributedZkTest, SolrCoreMetricManagerTest, DocValuesNotIndexedTest, HdfsSyncSliceTest, AddSchemaFieldsUpdateProcessorFactoryTest, HdfsChaosMonkeySafeLeaderTest, TestManagedSchema, ConvertedLegacyTest, TestBulkSchemaAPI, SortByFunctionTest, BJQParserTest, TestPKIAuthenticationPlugin, LeaderInitiatedRecoveryOnCommitTest, HdfsRecoveryZkTest, TestBadConfig, TestQueryUtils, SimpleCollectionCreateDeleteTest, EchoParamsTest, RequestHandlersTest, TestIndexSearcher, TestAddFieldRealTimeGet, TestRequestForwarding, TestSerializedLuceneMatchVersion, TestCustomDocTransformer, TestSolrXml, TestDistribIDF, TestNamedUpdateProcessors, TestFiltering, TestLeaderElectionZkExpiry, ShardRoutingCustomTest, ScriptEngineTest, TestSQLHandler, TestValueSourceCache, TestSchemaSimilarityResource, RegexBoostProcessorTest, DistanceFunctionTest, TestShortCircuitedRequests, UUIDFieldTest, TestCloudManagedSchema, MinimalSchemaTest, TestSchemaNameResource, TestSha256AuthenticationProvider, TestReqParamsAPI, NotRequiredUniqueKeyTest, TestTrieFacet, TestBlendedInfixSuggestions, ExternalFileFieldSortTest, TestTrie, ResourceLoaderTest, TestFuzzyAnalyzedSuggestions, CoreAdminHandlerTest, SolrIndexSplitterTest, ResponseLogComponentTest, ReplicationFactorTest, SuggesterTest, URLClassifyProcessorTest, TestConfigSets, TestManagedResourceStorage, BasicAuthIntegrationTest, CollectionStateFormat2Test, TestImpersonationWithHadoopAuth, CachingDirectoryFactoryTest, BasicFunctionalityTest, TestJettySolrRunner, HttpPartitionTest, TestUnifiedSolrHighlighter, CurrencyFieldOpenExchangeTest, TestLocalFSCloudBackupRestore, OverriddenZkACLAndCredentialsProvidersTest, BlockJoinFacetRandomTest, TestReload, SolrMetricReporterTest, TestReloadAndDeleteDocs, TestStressRecovery, WordBreakSolrSpellCheckerTest, TestNonDefinedSimilarityFactory, RecoveryZkTest, ClusterStateUpdateTest, ZkSolrClientTest, TestRandomDVFaceting, ZkCLITest, AutoCommitTest, TestDistributedGrouping, TestHashPartitioner, TermVectorComponentDistributedTest, TestStressReorder, TestJoin, SimpleFacetsTest, SolrCoreTest, TestGroupingSearch, PeerSyncTest, HighlighterTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SolrRequestParserTest, SuggesterTSTTest, SolrCoreCheckLockOnStartupTest, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, DocValuesMultiTest, XsltUpdateRequestHandlerTest, DebugComponentTest, DisMaxRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, XmlUpdateRequestHandlerTest, TermVectorComponentTest, RequiredFieldsTest, FastVectorHighlighterTest, TestCollationField, TestCSVResponseWriter, QueryParsingTest, JsonLoaderTest, TestPartialUpdateDeduplication, PingRequestHandlerTest, TestLFUCache, PreAnalyzedFieldTest, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, RAMDirectoryFactoryTest, TestDocumentBuilder, SliceStateTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping, ConnectionReuseTest, ActionThrottleTest, AssignTest, BaseCdcrDistributedZkTest, CdcrBootstrapTest, CollectionsAPIAsyncDistributedZkTest, DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest, LeaderElectionContextKeyTest, LeaderFailureAfterFreshStartTest, MissingSegmentRecoveryTest, OverseerModifyCollectionTest, OverseerStatusTest, PeerSyncReplicationTest, TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterSSL, TestOnReconnectListenerSupport, TestRandomFlRTGCloud, TestRebalanceLeaders, TestSegmentSorting, TestSolrCloudWithDelegationTokens, TestSolrCloudWithSecureImpersonation, TestStressLiveNodes, TestTolerantUpdateProcessorRandomCloud]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestTolerantUpdateProcessorRandomCloud -Dtests.seed=723A1655EA4FAD35 -Dtests.slow=true -Dtests.locale=ro -Dtests.timezone=America/Grenada -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestTolerantUpdateProcessorRandomCloud (suite) <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:64036/solr: Expected mime type application/octet-stream but got text/html. <html>
   [junit4]    > <head>
   [junit4]    > <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
   [junit4]    > <title>Error 404 </title>
   [junit4]    > </head>
   [junit4]    > <body>
   [junit4]    > <h2>HTTP ERROR: 404</h2>
   [junit4]    > <p>Problem accessing /solr/admin/collections. Reason:
   [junit4]    > <pre>    Can not find: /solr/admin/collections</pre></p>
   [junit4]    > <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/>
   [junit4]    > </body>
   [junit4]    > </html>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([723A1655EA4FAD35]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:595)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:439)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:391)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1358)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1109)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1042)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:177)
   [junit4]    > 	at org.apache.solr.cloud.TestTolerantUpdateProcessorRandomCloud.createMiniSolrCloudCluster(TestTolerantUpdateProcessorRandomCloud.java:111)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [532/694 (4!)] on J1 in 10.10s, 0 tests, 1 error <<< FAILURES!

[...truncated 63093 lines...]


Mime
View raw message