Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17967/
Java: 64bit/jdk-9-ea+136 -XX:+UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.client.solrj.impl.CloudSolrClientTest

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
  at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
  at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
  at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
  at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
  at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
  at 
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
  at 
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
  at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)  at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
  at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
  at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)  at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$11.evaluate(RandomizedRunner.java:968)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
  at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
  at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
  at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
  at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
  at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
  at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
  at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
  at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
  at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
  at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
  at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
  at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
  at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
  at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
  at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
  at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
  at java.lang.Thread.run(java.base@9-ea/Thread.java:843)  

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not 
released!!! [InternalHttpClient]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$11.evaluate(RandomizedRunner.java:968)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


        at __randomizedtesting.SeedInfo.seed([10BBAE9B6D5E6980]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:261)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  
junit.framework.TestSuite.org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest:     1) 
Thread[id=693, name=Connection evictor, state=TIMED_WAITING, 
group=TGRP-CloudSolrClientBuilderTest]         at 
java.lang.Thread.sleep(java.base@9-ea/Native Method)         at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
         at java.lang.Thread.run(java.base@9-ea/Thread.java:843)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest: 
   1) Thread[id=693, name=Connection evictor, state=TIMED_WAITING, 
group=TGRP-CloudSolrClientBuilderTest]
        at java.lang.Thread.sleep(java.base@9-ea/Native Method)
        at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
        at __randomizedtesting.SeedInfo.seed([10BBAE9B6D5E6980]:0)




Build Log:
[...truncated 13173 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest
   [junit4]   2> Oct 04, 2016 10:26:46 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> Oct 04, 2016 10:27:06 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest: 
   [junit4]   2>    1) Thread[id=693, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
   [junit4]   2>         at java.lang.Thread.sleep(java.base@9-ea/Native Method)
   [junit4]   2>         at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
   [junit4]   2>         at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> Oct 04, 2016 10:27:06 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=693, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
   [junit4]   2> Oct 04, 2016 10:27:06 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1554, maxMBSortInHeap=6.970493993582856, 
sim=ClassicSimilarity, locale=eo-001, timezone=America/Sao_Paulo
   [junit4]   2> NOTE: Linux 4.4.0-36-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=311699960,total=523239424
   [junit4]   2> NOTE: All tests run in this JVM: [GraphTest, 
LargeVolumeJettyTest, BasicHttpSolrClientTest, NamedListTest, SolrParamTest, 
TestHash, SolrSchemalessExampleTest, TestBatchUpdate, 
HttpSolrClientBuilderTest, JDBCStreamTest, ConcatOperationTest, 
TestToleratedUpdateError, ShardParamsTest, SolrExampleXMLTest, JettyWebappTest, 
TestSpellCheckResponse, MergeIndexesEmbeddedTest, TestFastInputStream, 
SolrDocumentTest, TestUpdateRequestCodec, GetByIdTest, TestSolrJErrorHandling, 
CloudSolrClientBuilderTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=CloudSolrClientBuilderTest -Dtests.seed=10BBAE9B6D5E6980 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=eo-001 
-Dtests.timezone=America/Sao_Paulo -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J2 | CloudSolrClientBuilderTest (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest: 
   [junit4]    >    1) Thread[id=693, name=Connection evictor, 
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
   [junit4]    >         at java.lang.Thread.sleep(java.base@9-ea/Native Method)
   [junit4]    >         at 
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
   [junit4]    >         at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([10BBAE9B6D5E6980]:0)
   [junit4] Completed [63/85 (1!)] on J2 in 20.08s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 61 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/init-core-data-001
   [junit4]   2> 74748 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 74749 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 74749 INFO  (Thread-178) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 74749 INFO  (Thread-178) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 74849 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:39935
   [junit4]   2> 74856 INFO  (jetty-launcher-128-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 74856 INFO  (jetty-launcher-128-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 74856 INFO  (jetty-launcher-128-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 74858 INFO  (jetty-launcher-128-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@8d18fe{/solr,null,AVAILABLE}
   [junit4]   2> 74858 INFO  (jetty-launcher-128-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@e733af1{/solr,null,AVAILABLE}
   [junit4]   2> 74858 INFO  (jetty-launcher-128-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4825075f{/solr,null,AVAILABLE}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@522c85bc{HTTP/1.1,[http/1.1]}{127.0.0.1:36646}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-2) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@267e97d8{HTTP/1.1,[http/1.1]}{127.0.0.1:38652}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.e.j.s.Server Started @77729ms
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-3) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@614e0cfe{HTTP/1.1,[http/1.1]}{127.0.0.1:34235}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36646}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-3) [    ] 
o.e.j.s.Server Started @77730ms
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34235}
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-2) [    ] 
o.e.j.s.Server Started @77730ms
   [junit4]   2> 74863 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38652}
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-04T10:27:06.648008Z
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 74864 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-04T10:27:06.648320Z
   [junit4]   2> 74865 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-04T10:27:06.648335Z
   [junit4]   2> 74868 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 74868 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 74868 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 74882 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39935/solr
   [junit4]   2> 74883 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39935/solr
   [junit4]   2> 74890 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39935/solr
   [junit4]   2> 74917 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34235_solr
   [junit4]   2> 74918 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36646_solr
   [junit4]   2> 74918 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38652_solr
   [junit4]   2> 74918 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.Overseer Overseer 
(id=96703402903732232-127.0.0.1:34235_solr-n_0000000000) starting
   [junit4]   2> 74919 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 74920 INFO  (zkCallback-143-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 74920 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 74920 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 74920 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 74920 INFO  (zkCallback-143-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 74928 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34235_solr
   [junit4]   2> 74929 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 74929 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 74932 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/.
   [junit4]   2> 74935 INFO  (zkCallback-143-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 74937 INFO  (jetty-launcher-128-thread-1) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/.
   [junit4]   2> 74946 INFO  (jetty-launcher-128-thread-3) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/.
   [junit4]   2> 74956 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 74965 INFO  (qtp1384361511-731) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 74968 INFO  (OverseerThreadFactory-257-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 75075 INFO  (qtp1384361511-736) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&name=collection1_shard1_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2
   [junit4]   2> 75075 INFO  (qtp860652263-723) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2
   [junit4]   2> 75183 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 75183 INFO  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 76085 INFO  (qtp1384361511-736) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 76085 INFO  (qtp860652263-723) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 76095 INFO  (qtp1384361511-736) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica1] Schema name=test
   [junit4]   2> 76095 INFO  (qtp860652263-723) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica1] Schema name=test
   [junit4]   2> 76146 WARN  (qtp1384361511-736) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 76148 WARN  (qtp1384361511-736) [    ] o.a.s.s.IndexSchema 
Field lowerfilt1and2 is not multivalued and destination for multiple copyFields 
(2)
   [junit4]   2> 76148 WARN  (qtp1384361511-736) [    ] o.a.s.s.IndexSchema 
Field text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 76149 INFO  (qtp1384361511-736) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 76149 INFO  (qtp1384361511-736) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica1' using configuration from 
collection collection1
   [junit4]   2> 76150 INFO  (qtp1384361511-736) [    ] o.a.s.c.SolrCore 
[[collection1_shard1_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/collection1_shard1_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/./collection1_shard1_replica1/data/]
   [junit4]   2> 76155 WARN  (qtp860652263-723) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica1] default search field in schema is text. WARNING: 
Deprecated, please use 'df' on request instead.
   [junit4]   2> 76158 WARN  (qtp860652263-723) [    ] o.a.s.s.IndexSchema 
Field lowerfilt1and2 is not multivalued and destination for multiple copyFields 
(2)
   [junit4]   2> 76158 WARN  (qtp860652263-723) [    ] o.a.s.s.IndexSchema 
Field text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 76158 INFO  (qtp860652263-723) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 76159 INFO  (qtp860652263-723) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica1' using configuration from 
collection collection1
   [junit4]   2> 76159 INFO  (qtp860652263-723) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/collection1_shard2_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/./collection1_shard2_replica1/data/]
   [junit4]   2> 76160 INFO  (qtp1384361511-736) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 76160 INFO  (qtp1384361511-736) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 76162 INFO  (qtp1384361511-736) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 76162 INFO  (qtp1384361511-736) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 76162 INFO  (qtp1384361511-736) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@51fd58ff[collection1_shard1_replica1] main]
   [junit4]   2> 76163 INFO  (qtp1384361511-736) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 76163 INFO  (qtp1384361511-736) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 76164 INFO  (qtp1384361511-736) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 76164 INFO  (qtp1384361511-736) [    ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1547254447942402048
   [junit4]   2> 76164 INFO  (searcherExecutor-264-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica1] Registered new searcher 
Searcher@51fd58ff[collection1_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 76169 INFO  (qtp860652263-723) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 76169 INFO  (qtp860652263-723) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 76169 INFO  (qtp860652263-723) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 76169 INFO  (qtp860652263-723) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 76170 INFO  (qtp860652263-723) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2902ad0c[collection1_shard2_replica1] main]
   [junit4]   2> 76171 INFO  (qtp860652263-723) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 76171 INFO  (qtp1384361511-736) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 76171 INFO  (qtp1384361511-736) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 76171 INFO  (qtp1384361511-736) [    ] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:38652/solr/collection1_shard1_replica1/
   [junit4]   2> 76171 INFO  (qtp1384361511-736) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 76172 INFO  (qtp1384361511-736) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:38652/solr/collection1_shard1_replica1/ has no replicas
   [junit4]   2> 76172 INFO  (qtp860652263-723) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 76173 INFO  (qtp860652263-723) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 76174 INFO  (qtp860652263-723) [    ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1547254447952887808
   [junit4]   2> 76174 INFO  (searcherExecutor-266-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica1] Registered new searcher 
Searcher@2902ad0c[collection1_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 76179 INFO  (qtp1384361511-736) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:38652/solr/collection1_shard1_replica1/ shard1
   [junit4]   2> 76181 INFO  (qtp860652263-723) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 76181 INFO  (qtp860652263-723) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 76181 INFO  (qtp860652263-723) [    ] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:34235/solr/collection1_shard2_replica1/
   [junit4]   2> 76181 INFO  (qtp860652263-723) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 76181 INFO  (qtp860652263-723) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:34235/solr/collection1_shard2_replica1/ has no replicas
   [junit4]   2> 76186 INFO  (qtp860652263-723) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:34235/solr/collection1_shard2_replica1/ shard2
   [junit4]   2> 76295 INFO  (zkCallback-143-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 76295 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 76330 INFO  (qtp1384361511-736) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 76332 INFO  (qtp1384361511-736) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&name=collection1_shard1_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2}
 status=0 QTime=1257
   [junit4]   2> 76343 INFO  (qtp860652263-723) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 76345 INFO  (qtp860652263-723) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2}
 status=0 QTime=1270
   [junit4]   2> 76349 INFO  (qtp1384361511-731) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 76447 INFO  (zkCallback-143-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 76447 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 76969 INFO  
(OverseerCollectionConfigSetProcessor-96703402903732232-127.0.0.1:34235_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 77349 INFO  (qtp1384361511-731) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=2384
   [junit4]   2> 77349 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
collection1 failOnTimeout:true timeout (sec):30
   [junit4]   2> 77350 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
   [junit4]   2> 77363 INFO  
(TEST-CloudSolrClientTest.testParallelUpdateQTime-seed#[10BBAE9B6D5E6980]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testParallelUpdateQTime
   [junit4]   2> 77374 INFO  (qtp860652263-727) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica1]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:38652/solr/collection1_shard1_replica1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1547254449205936128)} 0 5
   [junit4]   2> 77377 INFO  (qtp860652263-712) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 77377 INFO  (qtp860652263-712) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 77378 INFO  (qtp860652263-712) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 77378 INFO  (qtp860652263-712) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:38652/solr/collection1_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 77378 INFO  (qtp1384361511-736) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 77378 INFO  (qtp1384361511-736) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 77378 INFO  (qtp1384361511-736) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 77379 INFO  (qtp1384361511-736) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:38652/solr/collection1_shard1_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 77379 INFO  (qtp1384361511-734) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=collection1:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
 (-1547254449201741824),commit=} 0 14
   [junit4]   2> 77386 INFO  (qtp1384361511-718) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1]  webapp=/solr 
path=/update params={wt=javabin&version=2}{add=[1084 (1547254449219567616), 
1045 (1547254449223761920), 1067 (1547254449223761921), 1089 
(1547254449223761922)]} 0 4
   [junit4]   2> 77387 INFO  (qtp860652263-714) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica1]  webapp=/solr 
path=/update params={wt=javabin&version=2}{add=[1043 (1547254449219567616), 
1068 (1547254449224810496), 1081 (1547254449224810497), 1082 
(1547254449224810498), 1080 (1547254449224810499), 1014 (1547254449224810500)]} 
0 5
   [junit4]   2> 77387 INFO  
(TEST-CloudSolrClientTest.testParallelUpdateQTime-seed#[10BBAE9B6D5E6980]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testParallelUpdateQTime
   [junit4]   2> 77401 INFO  
(TEST-CloudSolrClientTest.preferLocalShardsTest-seed#[10BBAE9B6D5E6980]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting preferLocalShardsTest
   [junit4]   2> 77409 INFO  (qtp1384361511-736) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@222c7328[collection1_shard1_replica1] realtime]
   [junit4]   2> 77409 INFO  (qtp860652263-727) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@374a802d[collection1_shard2_replica1] realtime]
   [junit4]   2> 77410 INFO  (qtp1384361511-736) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:34235/solr/collection1_shard2_replica1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1547254449242636288)} 0 5
   [junit4]   2> 77412 INFO  (qtp1384361511-734) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 77412 INFO  (qtp1384361511-734) [    ] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5fbd2e34
   [junit4]   2> 77413 INFO  (qtp1384361511-734) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6d09da33[collection1_shard1_replica1] main]
   [junit4]   2> 77414 INFO  (qtp1384361511-734) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 77414 INFO  (searcherExecutor-264-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica1] Registered new searcher 
Searcher@6d09da33[collection1_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 77414 INFO  (qtp860652263-717) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 77414 INFO  (qtp1384361511-734) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:34235/solr/collection1_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 2
   [junit4]   2> 77414 INFO  (qtp860652263-717) [    ] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@46e24d9e
   [junit4]   2> 77415 INFO  (qtp860652263-717) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3229df0c[collection1_shard2_replica1] main]
   [junit4]   2> 77416 INFO  (qtp860652263-717) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 77416 INFO  (searcherExecutor-266-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica1] Registered new searcher 
Searcher@3229df0c[collection1_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 77416 INFO  (qtp860652263-717) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:34235/solr/collection1_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 2
   [junit4]   2> 77416 INFO  (qtp860652263-727) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=collection1:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
 (-1547254449240539136),commit=} 0 14
   [junit4]   2> 77417 INFO  (qtp1384361511-722) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
async=8bc2e539-06b0-42ae-b757-2590f367bc96&replicationFactor=3&collection.configName=conf&maxShardsPerNode=3&name=localShardsTestColl&action=CREATE&numShards=3&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 77418 INFO  (qtp1384361511-722) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc96&replicationFactor=3&collection.configName=conf&maxShardsPerNode=3&name=localShardsTestColl&action=CREATE&numShards=3&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 77420 INFO  (OverseerThreadFactory-257-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd Create collection localShardsTestColl
   [junit4]   2> 77421 INFO  (qtp1384361511-726) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 77422 INFO  (qtp1384361511-726) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77628 INFO  (qtp860652263-725) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999443936381&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 77628 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444538806&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2
   [junit4]   2> 77628 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999443936381&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2
   [junit4]   2> 77628 INFO  (qtp1384361511-715) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444538806&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2}
 status=0 QTime=3
   [junit4]   2> 77628 INFO  (qtp1384361511-722) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999445105566&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999445105566&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (qtp860652263-717) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444617736&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 77629 INFO  (qtp1949358455-730) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444915349&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77629 INFO  (qtp1384361511-726) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999447824263&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444915349&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard3_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard3&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (qtp860652263-723) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999447824263&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica3&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999444617736&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999445581183&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica1&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2
   [junit4]   2> 77629 INFO  (qtp1949358455-730) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999445581183&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard1_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77631 INFO  (qtp1949358455-733) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={async=8bc2e539-06b0-42ae-b757-2590f367bc962495999448608223&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77631 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
async=8bc2e539-06b0-42ae-b757-2590f367bc962495999448608223&qt=/admin/cores&collection.configName=conf&name=localShardsTestColl_shard2_replica2&action=CREATE&numShards=3&collection=localShardsTestColl&shard=shard2&wt=javabin&version=2
   [junit4]   2> 77631 INFO  (qtp860652263-725) [    ] 
o.a.s.h.a.CoreAdminOperation Checking request status for : 
8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728
   [junit4]   2> 77631 INFO  (qtp860652263-725) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 77742 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 77742 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 77742 INFO  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 78423 INFO  (qtp1384361511-736) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 78424 INFO  (qtp1384361511-736) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 78634 INFO  (qtp860652263-717) [    ] 
o.a.s.h.a.CoreAdminOperation Checking request status for : 
8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728
   [junit4]   2> 78634 INFO  (qtp860652263-717) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=8bc2e539-06b0-42ae-b757-2590f367bc962495999446890728&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 78651 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78651 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78651 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78652 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78661 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78665 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica2] Schema name=test
   [junit4]   2> 78670 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica2] Schema name=test
   [junit4]   2> 78671 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica2] Schema name=test
   [junit4]   2> 78672 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78693 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78707 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78708 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica1] Schema name=test
   [junit4]   2> 78731 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 78738 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica3] Schema name=test
   [junit4]   2> 78738 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica1] Schema name=test
   [junit4]   2> 78739 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica3] Schema name=test
   [junit4]   2> 78745 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica1] Schema name=test
   [junit4]   2> 78759 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica3] Schema name=test
   [junit4]   2> 78786 WARN  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica2] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78791 WARN  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78791 WARN  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78792 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78795 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard1_replica2' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78796 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard1_replica2] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/localShardsTestColl_shard1_replica2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/./localShardsTestColl_shard1_replica2/data/]
   [junit4]   2> 78817 WARN  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica2] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78830 WARN  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78830 WARN  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78831 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78845 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard3_replica2' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78846 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard3_replica2] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/localShardsTestColl_shard3_replica2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/./localShardsTestColl_shard3_replica2/data/]
   [junit4]   2> 78852 WARN  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica2] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78853 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78853 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78854 WARN  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78854 WARN  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78854 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78854 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78854 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78855 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard2_replica2' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78855 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@553050b2[localShardsTestColl_shard1_replica2] main]
   [junit4]   2> 78855 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard2_replica2] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/localShardsTestColl_shard2_replica2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node1/./localShardsTestColl_shard2_replica2/data/]
   [junit4]   2> 78856 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78856 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78856 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78857 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78857 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78857 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78857 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78858 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2fda223f[localShardsTestColl_shard3_replica2] main]
   [junit4]   2> 78858 INFO  (searcherExecutor-274-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard1_replica2] Registered new searcher 
Searcher@553050b2[localShardsTestColl_shard1_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78858 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450767265792
   [junit4]   2> 78864 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78864 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78864 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78864 INFO  (searcherExecutor-275-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard3_replica2] Registered new searcher 
Searcher@2fda223f[localShardsTestColl_shard3_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78865 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450774605824
   [junit4]   2> 78878 WARN  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica3] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78879 WARN  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78880 WARN  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78880 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78882 WARN  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78884 WARN  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard2_replica3] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78884 WARN  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78885 WARN  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78885 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78886 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard3_replica3' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78886 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard3_replica3] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/localShardsTestColl_shard3_replica3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/./localShardsTestColl_shard3_replica3/data/]
   [junit4]   2> 78887 WARN  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78887 WARN  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78888 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard2_replica1' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78888 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard2_replica1] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/localShardsTestColl_shard2_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/./localShardsTestColl_shard2_replica1/data/]
   [junit4]   2> 78897 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78946 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard2_replica3' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78947 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard3: total=3 found=1 timeoutin=9999ms
   [junit4]   2> 78947 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=3 found=1 timeoutin=9999ms
   [junit4]   2> 78951 WARN  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard3_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78952 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard2_replica3] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/localShardsTestColl_shard2_replica3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/./localShardsTestColl_shard2_replica3/data/]
   [junit4]   2> 78953 WARN  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78953 WARN  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78954 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78954 WARN  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica3] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78954 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard3_replica1' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78955 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard3_replica1] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/localShardsTestColl_shard3_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/./localShardsTestColl_shard3_replica1/data/]
   [junit4]   2> 78957 WARN  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78957 WARN  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78958 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78958 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard1_replica3' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78959 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard1_replica3] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/localShardsTestColl_shard1_replica3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node2/./localShardsTestColl_shard1_replica3/data/]
   [junit4]   2> 78966 WARN  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.IndexSchema [localShardsTestColl_shard1_replica1] default search field 
in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 78967 WARN  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 78967 WARN  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 78968 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 78969 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78969 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78969 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78969 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78969 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'localShardsTestColl_shard1_replica1' 
using configuration from collection localShardsTestColl
   [junit4]   2> 78970 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.c.SolrCore [[localShardsTestColl_shard1_replica1] ] Opening new SolrCore 
at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/localShardsTestColl_shard1_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.impl.CloudSolrClientTest_10BBAE9B6D5E6980-001/tempDir-001/node3/./localShardsTestColl_shard1_replica1/data/]
   [junit4]   2> 78970 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78970 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78970 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78970 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78971 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6510a6bd[localShardsTestColl_shard2_replica1] main]
   [junit4]   2> 78971 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6ab020e6[localShardsTestColl_shard2_replica2] main]
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78972 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78973 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78973 INFO  (searcherExecutor-281-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard2_replica2] Registered new searcher 
Searcher@6ab020e6[localShardsTestColl_shard2_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78973 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450887852032
   [junit4]   2> 78973 INFO  (parallelCoreAdminExecutor-260-thread-3) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450887852032
   [junit4]   2> 78974 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78974 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78974 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3ac66171[localShardsTestColl_shard3_replica3] main]
   [junit4]   2> 78979 INFO  (searcherExecutor-287-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard2_replica1] Registered new searcher 
Searcher@6510a6bd[localShardsTestColl_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78982 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78984 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78984 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78984 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78984 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78985 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78985 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78986 INFO  (parallelCoreAdminExecutor-262-thread-2) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=3 found=2 timeoutin=9999ms
   [junit4]   2> 78986 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@70846acf[localShardsTestColl_shard3_replica1] main]
   [junit4]   2> 78987 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78987 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78987 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 78988 INFO  (searcherExecutor-286-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard3_replica3] Registered new searcher 
Searcher@3ac66171[localShardsTestColl_shard3_replica3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-258-thread-2) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450903580672
   [junit4]   2> 78988 INFO  (searcherExecutor-290-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard3_replica1] Registered new searcher 
Searcher@70846acf[localShardsTestColl_shard3_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-262-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450903580672
   [junit4]   2> 78988 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78991 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@8c5d478[localShardsTestColl_shard1_replica3] main]
   [junit4]   2> 78991 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 78991 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 78994 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@50d128ec[localShardsTestColl_shard1_replica1] main]
   [junit4]   2> 78999 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 78999 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 78999 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 79000 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 79000 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 79000 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 79001 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 79001 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5d17052[localShardsTestColl_shard2_replica3] main]
   [junit4]   2> 79001 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 79001 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 79001 INFO  (searcherExecutor-291-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard1_replica3] Registered new searcher 
Searcher@8c5d478[localShardsTestColl_shard1_replica3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 79002 INFO  (parallelCoreAdminExecutor-258-thread-1) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450918260736
   [junit4]   2> 79002 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 79002 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 79002 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 79002 INFO  (searcherExecutor-288-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard2_replica3] Registered new searcher 
Searcher@5d17052[localShardsTestColl_shard2_replica3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 79001 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 79002 INFO  (parallelCoreAdminExecutor-258-thread-3) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450918260736
   [junit4]   2> 79003 INFO  (searcherExecutor-295-thread-1) [    ] 
o.a.s.c.SolrCore [localShardsTestColl_shard1_replica1] Registered new searcher 
Searcher@50d128ec[localShardsTestColl_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 79003 INFO  (parallelCoreAdminExecutor-262-thread-3) [    ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1547254450919309312
   [junit4]   2> 79089 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 79089 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 79089 INFO  (zkCallback-143-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 79425 INFO  (qtp1384361511-715) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 79426 INFO  (qtp1384361511-715) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={requestid=8bc2e539-06b0-42ae-b757-2590f367bc96&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:36646/solr/localShardsTestColl_shard3_replica2/
   [junit4]   2> 79447 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:36646/solr/localShardsTestColl_shard1_replica2/
   [junit4]   2> 79451 INFO  (parallelCoreAdminExecutor-260-thread-2) [    ] 
o.a.s.u.PeerSync PeerSync: core=localShardsTestColl_shard1_replica2 
url=http://127.0.0.1:36646/solr START 
replicas=[http://127.0.0.1:38652/solr/localShardsTestColl_shard1_replica3/, 
http://127.0.0.1:34235/solr/localShardsTestColl_shard1_replica1/] nUpdates=100
   [junit4]   2> 79451 INFO  (parallelCoreAdminExecutor-260-thread-1) [    ] 
o.a.s.u.PeerSync PeerSync: core=localShardsTestColl_shard3_replica2 
url=http://127.0.0.1:36646/solr START 
replicas=[http://127.0.0.1:34235/solr/localShardsTestColl_shard3_replica1/, 
http://127.0.0.1:38652/solr/localShardsTestColl_shard3_replica3/]

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

 107404 INFO  (zkCallback-144-thread-1) [    ] o.a.s.c.c.ZkStateReader A 
cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107404 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/localShardsTestColl/state.json] for collection 
[localShardsTestColl] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107406 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/foo/state.json] for 
collection [foo] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107406 INFO  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/foo/state.json] for 
collection [foo] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107406 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/foo/state.json] for 
collection [foo] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107407 INFO  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/multicollection1/state.json] for collection 
[multicollection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107407 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/multicollection1/state.json] for collection 
[multicollection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 107414 INFO  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 107414 INFO  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 107417 WARN  (zkCallback-142-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 107417 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1578f3b8aa60007, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 107417 INFO  (zkCallback-144-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 107423 INFO  (jetty-launcher-128-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4825075f{/solr,null,UNAVAILABLE}
   [junit4]   2> 107424 INFO  (jetty-launcher-128-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=96703402903732232-127.0.0.1:34235_solr-n_0000000000) closing
   [junit4]   2> 107425 INFO  
(OverseerStateUpdate-96703402903732232-127.0.0.1:34235_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34235_solr
   [junit4]   2> 107436 WARN  (zkCallback-144-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 107436 INFO  (jetty-launcher-128-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@e733af1{/solr,null,UNAVAILABLE}
   [junit4]   2> 107436 INFO  (zkCallback-143-thread-4) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 107437 WARN  (zkCallback-143-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 108936 INFO  (jetty-launcher-128-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@8d18fe{/solr,null,UNAVAILABLE}
   [junit4]   2> 108937 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39935 39935
   [junit4]   2> 109095 INFO  (Thread-178) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39935 39935
   [junit4]   2> 109095 WARN  (Thread-178) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        7       /solr/clusterprops.json
   [junit4]   2>        3       /solr/security.json
   [junit4]   2>        3       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        3       /solr/collections/foo/state.json
   [junit4]   2>        3       /solr/collections/localShardsTestColl/state.json
   [junit4]   2>        2       /solr/collections/collection1/state.json
   [junit4]   2>        2       /solr/collections/multicollection2/state.json
   [junit4]   2>        2       /solr/collections/multicollection1/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        30      /solr/overseer/queue
   [junit4]   2>        21      /solr/overseer/collection-queue-work
   [junit4]   2>        13      /solr/overseer/queue-work
   [junit4]   2>        7       /solr/live_nodes
   [junit4]   2>        7       /solr/collections
   [junit4]   2> 
   [junit4]   2> 109095 INFO  
(SUITE-CloudSolrClientTest-seed#[10BBAE9B6D5E6980]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3254, maxDocsPerChunk=2, blockSize=10), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3254, blockSize=10)), sim=ClassicSimilarity, locale=hu, 
timezone=Indian/Comoro
   [junit4]   2> NOTE: Linux 4.4.0-36-generic amd64/Oracle Corporation 9-ea 
(64-bit)/cpus=12,threads=1,free=336480768,total=516423680
   [junit4]   2> NOTE: All tests run in this JVM: [GraphTest, 
LargeVolumeJettyTest, BasicHttpSolrClientTest, NamedListTest, SolrParamTest, 
TestHash, SolrSchemalessExampleTest, TestBatchUpdate, 
HttpSolrClientBuilderTest, JDBCStreamTest, ConcatOperationTest, 
TestToleratedUpdateError, ShardParamsTest, SolrExampleXMLTest, JettyWebappTest, 
TestSpellCheckResponse, MergeIndexesEmbeddedTest, TestFastInputStream, 
SolrDocumentTest, TestUpdateRequestCodec, GetByIdTest, TestSolrJErrorHandling, 
CloudSolrClientBuilderTest, CloudSolrClientMultiConstructorTest, 
CloudSolrClientTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CloudSolrClientTest 
-Dtests.seed=10BBAE9B6D5E6980 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=hu -Dtests.timezone=Indian/Comoro -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J2 | CloudSolrClientTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 1 
object(s) that were not released!!! [InternalHttpClient]
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([10BBAE9B6D5E6980]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:261)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native 
Method)
   [junit4]    >        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4] Completed [84/85 (2!)] on J2 in 65.38s, 10 tests, 1 failure <<< 
FAILURES!

[...truncated 49176 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to