Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20869/
Java: 32bit/jdk1.8.0_144 -client -XX:+UseConcMarkSweepGC

3 tests failed.
FAILED:  
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet

Error Message:
Error from server at http://127.0.0.1:34513/solr: Could not fully remove 
collection: solrj_default_configset

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34513/solr: Could not fully remove collection: 
solrj_default_configset
        at 
__randomizedtesting.SeedInfo.seed([6A717A29D96C49C8:24DADB6E86D3333B]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1096)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:875)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:808)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
        at 
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateWithDefaultConfigSet(CollectionsAPISolrJTest.java:81)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.cloud.CollectionsAPISolrJTest.testCloudInfoInCoreStatus

Error Message:
Error from server at http://127.0.0.1:34513/solr: Could not fully create 
collection: corestatus_test

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34513/solr: Could not fully create collection: 
corestatus_test
        at 
__randomizedtesting.SeedInfo.seed([6A717A29D96C49C8:4A37ED0021BFF4E6]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1096)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:875)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:808)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
        at 
org.apache.solr.cloud.CollectionsAPISolrJTest.testCloudInfoInCoreStatus(CollectionsAPISolrJTest.java:134)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple

Error Message:
Error from server at https://127.0.0.1:46149/solr: create the collection time 
out:180s

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:46149/solr: create the collection time out:180s
        at 
__randomizedtesting.SeedInfo.seed([6A717A29D96C49C8:52C25ED7FE9F9D19]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1096)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:875)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:808)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
        at 
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple(AutoAddReplicasIntegrationTest.java:67)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13191 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/init-core-data-001
   [junit4]   2> 2227475 WARN  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
   [junit4]   2> 2227475 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2227476 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2227476 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2227477 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001
   [junit4]   2> 2227477 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2227477 INFO  (Thread-4112) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2227477 INFO  (Thread-4112) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2227479 ERROR (Thread-4112) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2227577 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:34227
   [junit4]   2> 2227585 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 0x15f9ed93a530000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2227587 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2227587 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2227586 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2227599 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2227603 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@14abae6{/solr,null,AVAILABLE}
   [junit4]   2> 2227605 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@51d7f6{HTTP/1.1,[http/1.1]}{127.0.0.1:35263}
   [junit4]   2> 2227605 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.e.j.s.Server Started @2229211ms
   [junit4]   2> 2227605 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=35263}
   [junit4]   2> 2227606 ERROR (jetty-launcher-4737-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2227606 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 2227606 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2227606 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2227606 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-09T03:35:57.395Z
   [junit4]   2> 2227609 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1a43a09{/solr,null,AVAILABLE}
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@d1ca78{HTTP/1.1,[http/1.1]}{127.0.0.1:40233}
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.e.j.s.Server Started @2229216ms
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40233}
   [junit4]   2> 2227610 ERROR (jetty-launcher-4737-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2227610 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-09T03:35:57.399Z
   [junit4]   2> 2227614 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2227621 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@c8f19f{/solr,null,AVAILABLE}
   [junit4]   2> 2227621 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@18fd7a4{HTTP/1.1,[http/1.1]}{127.0.0.1:41713}
   [junit4]   2> 2227621 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.e.j.s.Server Started @2229227ms
   [junit4]   2> 2227621 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41713}
   [junit4]   2> 2227622 ERROR (jetty-launcher-4737-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2227622 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 2227622 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2227622 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2227622 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-09T03:35:57.411Z
   [junit4]   2> 2227624 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@14ce854{/solr,null,AVAILABLE}
   [junit4]   2> 2227624 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@110c41f{HTTP/1.1,[http/1.1]}{127.0.0.1:34513}
   [junit4]   2> 2227624 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.e.j.s.Server Started @2229230ms
   [junit4]   2> 2227624 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34513}
   [junit4]   2> 2227624 ERROR (jetty-launcher-4737-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2227625 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 2227625 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2227625 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2227625 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-09T03:35:57.414Z
   [junit4]   2> 2227626 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2227626 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2227637 INFO  (jetty-launcher-4737-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34227/solr
   [junit4]   2> 2227647 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2227651 INFO  (jetty-launcher-4737-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34227/solr
   [junit4]   2> 2227651 INFO  (jetty-launcher-4737-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34227/solr
   [junit4]   2> 2227674 INFO  (jetty-launcher-4737-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34227/solr
   [junit4]   2> 2227678 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 0x15f9ed93a530007, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2227683 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 0x15f9ed93a53000a, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2227807 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2227808 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:34513_solr
   [junit4]   2> 2227808 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2227809 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.Overseer Overseer 
(id=98972372649050124-127.0.0.1:34513_solr-n_0000000000) starting
   [junit4]   2> 2227810 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41713_solr
   [junit4]   2> 2227813 INFO  
(zkCallback-4759-thread-1-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2227816 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2227825 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2227826 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2227829 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2227833 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2227834 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40233_solr
   [junit4]   2> 2227835 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2227836 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2227837 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35263_solr
   [junit4]   2> 2227852 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2227852 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2227853 INFO  
(zkCallback-4753-thread-1-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2227861 INFO  
(zkCallback-4759-thread-2-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2227862 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34513_solr
   [junit4]   2> 2227863 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2227863 INFO  
(zkCallback-4759-thread-2-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2227868 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2227869 INFO  
(zkCallback-4753-thread-1-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 2228107 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40233.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228121 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40233.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228122 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40233.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228124 INFO  (jetty-launcher-4737-thread-1) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node1/.
   [junit4]   2> 2228209 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35263.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228210 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41713.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228223 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35263.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228224 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35263.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228226 INFO  (jetty-launcher-4737-thread-2) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node2/.
   [junit4]   2> 2228227 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41713.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228228 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41713.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228230 INFO  (jetty-launcher-4737-thread-3) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node3/.
   [junit4]   2> 2228304 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34513.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228314 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34513.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228314 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34513.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2228315 INFO  (jetty-launcher-4737-thread-4) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node4/.
   [junit4]   2> 2228391 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 2228391 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34227/solr ready
   [junit4]   2> 2228456 INFO  
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[6A717A29D96C49C8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testClusterProp
   [junit4]   2> 2228460 INFO  (qtp6257815-20464) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params 
val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2228460 INFO  (qtp6257815-20464) [n:127.0.0.1:34513_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=1
   [junit4]   2> 2228462 INFO  (qtp6257815-20465) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params 
name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2228463 INFO  (qtp6257815-20465) [n:127.0.0.1:34513_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 
QTime=0
   [junit4]   2> 2228464 INFO  (qtp6257815-20466) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params 
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 2228464 INFO  (qtp6257815-20466) [n:127.0.0.1:34513_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=0
   [junit4]   2> 2228465 INFO  
(TEST-CollectionsAPISolrJTest.testClusterProp-seed#[6A717A29D96C49C8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testClusterProp
   [junit4]   2> 2228534 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[6A717A29D96C49C8]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testOverseerStatus
   [junit4]   2> 2228536 INFO  (qtp6257815-20429) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2228544 INFO  (qtp6257815-20429) [n:127.0.0.1:34513_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=8
   [junit4]   2> 2228545 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[6A717A29D96C49C8]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatus
   [junit4]   2> 2228608 INFO  
(TEST-CollectionsAPISolrJTest.testCreateAndDeleteShard-seed#[6A717A29D96C49C8]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateAndDeleteShard
   [junit4]   2> 2228610 INFO  (qtp6257815-20464) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=1&shards=shardA,shardB&replicationFactor=1&collection.configName=conf&maxShardsPerNode=3&name=solrj_implicit&router.name=implicit&nrtReplicas=1&action=CREATE&tlogReplicas=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2228612 INFO  
(OverseerThreadFactory-7165-thread-2-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
solrj_implicit
   [junit4]   2> 2228613 INFO  
(OverseerCollectionConfigSetProcessor-98972372649050124-127.0.0.1:34513_solr-n_0000000000)
 [n:127.0.0.1:34513_solr    ] 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> 2228719 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardA",
   [junit4]   2>   "core":"solrj_implicit_shardA_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:41713/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228721 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardA",
   [junit4]   2>   "core":"solrj_implicit_shardA_replica_t2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:40233/solr";,
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228722 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardA",
   [junit4]   2>   "core":"solrj_implicit_shardA_replica_p4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:35263/solr";,
   [junit4]   2>   "type":"PULL",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228724 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardB",
   [junit4]   2>   "core":"solrj_implicit_shardB_replica_n7",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34513/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228726 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardB",
   [junit4]   2>   "core":"solrj_implicit_shardB_replica_t8",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:41713/solr";,
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228727 INFO  
(OverseerStateUpdate-98972372649050124-127.0.0.1:34513_solr-n_0000000000) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"solrj_implicit",
   [junit4]   2>   "shard":"shardB",
   [junit4]   2>   "core":"solrj_implicit_shardB_replica_p10",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:40233/solr";,
   [junit4]   2>   "type":"PULL",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2228931 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_n7&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2228932 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2228933 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node12&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_p10&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 2228933 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 2228933 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node11&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_t8&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 2228933 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2228933 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2228934 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_t2&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 2228934 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_p4&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 2228934 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2229044 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229044 INFO  
(zkCallback-4753-thread-1-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229044 INFO  
(zkCallback-4753-thread-2-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229045 INFO  
(zkCallback-4758-thread-2-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229044 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229045 INFO  
(zkCallback-4754-thread-2-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229044 INFO  
(zkCallback-4759-thread-1-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229044 INFO  
(zkCallback-4759-thread-2-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2229996 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2229996 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2229996 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2230024 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2230026 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2230033 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2230072 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_n1] Schema name=minimal
   [junit4]   2> 2230100 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_p4] Schema name=minimal
   [junit4]   2> 2230102 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_p10] Schema name=minimal
   [junit4]   2> 2230104 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230104 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_n1' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230105 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41713.solr.core.solrj_implicit.shardA.replica_n1' (registry 
'solr.core.solrj_implicit.shardA.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230105 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230105 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node3/solrj_implicit_shardA_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node3/./solrj_implicit_shardA_replica_n1/data/]
   [junit4]   2> 2230105 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230105 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_p4' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230106 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35263.solr.core.solrj_implicit.shardA.replica_p4' (registry 
'solr.core.solrj_implicit.shardA.replica_p4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230106 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230106 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_p4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node2/solrj_implicit_shardA_replica_p4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node2/./solrj_implicit_shardA_replica_p4/data/]
   [junit4]   2> 2230108 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230108 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_p10' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230112 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.s.IndexSchema [solrj_implicit_shardA_replica_t2] Schema name=minimal
   [junit4]   2> 2230113 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_t8] Schema name=minimal
   [junit4]   2> 2230113 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.s.IndexSchema [solrj_implicit_shardB_replica_n7] Schema name=minimal
   [junit4]   2> 2230115 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230115 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardA_replica_t2' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230116 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40233.solr.core.solrj_implicit.shardA.replica_t2' (registry 
'solr.core.solrj_implicit.shardA.replica_t2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230116 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230116 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.c.SolrCore [[solrj_implicit_shardA_replica_t2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node1/solrj_implicit_shardA_replica_t2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node1/./solrj_implicit_shardA_replica_t2/data/]
   [junit4]   2> 2230117 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230117 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_n7' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230117 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40233.solr.core.solrj_implicit.shardB.replica_p10' (registry 
'solr.core.solrj_implicit.shardB.replica_p10') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230118 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230118 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_p10] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node1/solrj_implicit_shardB_replica_p10],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node1/./solrj_implicit_shardB_replica_p10/data/]
   [junit4]   2> 2230118 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34513.solr.core.solrj_implicit.shardB.replica_n7' (registry 
'solr.core.solrj_implicit.shardB.replica_n7') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230118 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230118 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_n7] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node4/solrj_implicit_shardB_replica_n7],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node4/./solrj_implicit_shardB_replica_n7/data/]
   [junit4]   2> 2230145 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2230145 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.c.CoreContainer Creating SolrCore 'solrj_implicit_shardB_replica_t8' 
using configuration from collection solrj_implicit, trusted=true
   [junit4]   2> 2230146 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41713.solr.core.solrj_implicit.shardB.replica_t8' (registry 
'solr.core.solrj_implicit.shardB.replica_t8') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@16576f5
   [junit4]   2> 2230147 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2230147 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.c.SolrCore [[solrj_implicit_shardB_replica_t8] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node3/solrj_implicit_shardB_replica_t8],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPISolrJTest_6A717A29D96C49C8-001/tempDir-001/node3/./solrj_implicit_shardB_replica_t8/data/]
   [junit4]   2> 2230322 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2230322 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2230324 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230324 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230326 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@16cb703[solrj_implicit_shardB_replica_n7] main]
   [junit4]   2> 2230329 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230330 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230330 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230336 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230337 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230337 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2230337 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2230339 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230339 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230339 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2230339 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2230340 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230341 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@19a24cf[solrj_implicit_shardA_replica_t2] main]
   [junit4]   2> 2230341 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230341 INFO  
(searcherExecutor-7178-thread-1-processing-n:127.0.0.1:34513_solr 
x:solrj_implicit_shardB_replica_n7 s:shardB c:solrj_implicit r:core_node9) 
[n:127.0.0.1:34513_solr c:solrj_implicit s:shardB r:core_node9 
x:solrj_implicit_shardB_replica_n7] o.a.s.c.SolrCore 
[solrj_implicit_shardB_replica_n7] Registered new searcher 
Searcher@16cb703[solrj_implicit_shardB_replica_n7] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230341 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583557965386874880
   [junit4]   2> 2230342 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230343 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230343 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1c3b9c1[solrj_implicit_shardA_replica_n1] main]
   [junit4]   2> 2230344 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230344 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230344 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230345 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230346 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230346 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583557965392117760
   [junit4]   2> 2230347 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@dd7db1[solrj_implicit_shardA_replica_p4] main]
   [junit4]   2> 2230348 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230349 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230349 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@510c26[solrj_implicit_shardB_replica_p10] main]
   [junit4]   2> 2230350 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230350 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230351 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shardB: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2230351 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230352 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230352 INFO  
(searcherExecutor-7175-thread-1-processing-n:127.0.0.1:35263_solr 
x:solrj_implicit_shardA_replica_p4 s:shardA c:solrj_implicit r:core_node6) 
[n:127.0.0.1:35263_solr c:solrj_implicit s:shardA r:core_node6 
x:solrj_implicit_shardA_replica_p4] o.a.s.c.SolrCore 
[solrj_implicit_shardA_replica_p4] Registered new searcher 
Searcher@dd7db1[solrj_implicit_shardA_replica_p4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230352 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shardA: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 2230353 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.ZkController solrj_implicit_shardA_replica_p4 starting background 
replication from leader
   [junit4]   2> 2230353 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:03
   [junit4]   2> 2230354 INFO  
(searcherExecutor-7177-thread-1-processing-n:127.0.0.1:40233_solr 
x:solrj_implicit_shardA_replica_t2 s:shardA c:solrj_implicit r:core_node5) 
[n:127.0.0.1:40233_solr c:solrj_implicit s:shardA r:core_node5 
x:solrj_implicit_shardA_replica_t2] o.a.s.c.SolrCore 
[solrj_implicit_shardA_replica_t2] Registered new searcher 
Searcher@19a24cf[solrj_implicit_shardA_replica_t2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230354 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
   [junit4]   2> 2230355 INFO  (qtp28497539-20433) [n:127.0.0.1:35263_solr 
c:solrj_implicit s:shardA r:core_node6 x:solrj_implicit_shardA_replica_p4] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230355 INFO  
(searcherExecutor-7174-thread-1-processing-n:127.0.0.1:41713_solr 
x:solrj_implicit_shardA_replica_n1 s:shardA c:solrj_implicit r:core_node3) 
[n:127.0.0.1:41713_solr c:solrj_implicit s:shardA r:core_node3 
x:solrj_implicit_shardA_replica_n1] o.a.s.c.SolrCore 
[solrj_implicit_shardA_replica_n1] Registered new searcher 
Searcher@1c3b9c1[solrj_implicit_shardA_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230355 INFO  (qtp10506257-20441) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583557965401554944
   [junit4]   2> 2230353 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230356 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2230356 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2230356 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.ZkController solrj_implicit_shardB_replica_p10 starting background 
replication from leader
   [junit4]   2> 2230356 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:03
   [junit4]   2> 2230357 INFO  
(searcherExecutor-7176-thread-1-processing-n:127.0.0.1:40233_solr 
x:solrj_implicit_shardB_replica_p10 s:shardB c:solrj_implicit r:core_node12) 
[n:127.0.0.1:40233_solr c:solrj_implicit s:shardB r:core_node12 
x:solrj_implicit_shardB_replica_p10] o.a.s.c.SolrCore 
[solrj_implicit_shardB_replica_p10] Registered new searcher 
Searcher@510c26[solrj_implicit_shardB_replica_p10] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230358 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 3000ms
   [junit4]   2> 2230358 INFO  (qtp10506257-20430) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardB r:core_node12 x:solrj_implicit_shardB_replica_p10] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230358 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2230358 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2230360 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@917930[solrj_implicit_shardB_replica_t8] main]
   [junit4]   2> 2230360 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 2230360 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2230387 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2230389 INFO  
(searcherExecutor-7179-thread-1-processing-n:127.0.0.1:41713_solr 
x:solrj_implicit_shardB_replica_t8 s:shardB c:solrj_implicit r:core_node11) 
[n:127.0.0.1:41713_solr c:solrj_implicit s:shardB r:core_node11 
x:solrj_implicit_shardB_replica_t8] o.a.s.c.SolrCore 
[solrj_implicit_shardB_replica_t8] Registered new searcher 
Searcher@917930[solrj_implicit_shardB_replica_t8] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2230389 INFO  (qtp32796086-20456) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1583557965437206528
   [junit4]   2> 2230453 INFO  
(zkCallback-4758-thread-2-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230453 INFO  
(zkCallback-4759-thread-3-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230453 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230453 INFO  
(zkCallback-4753-thread-2-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230453 INFO  
(zkCallback-4759-thread-1-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230453 INFO  
(zkCallback-4753-thread-1-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230454 INFO  
(zkCallback-4754-thread-2-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230454 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2230851 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2230852 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2230852 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:34513/solr/solrj_implicit_shardB_replica_n7/
   [junit4]   2> 2230852 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardB_replica_n7 
url=http://127.0.0.1:34513/solr START 
replicas=[http://127.0.0.1:41713/solr/solrj_implicit_shardB_replica_t8/] 
nUpdates=100
   [junit4]   2> 2230853 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 2230853 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 2230853 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:41713/solr/solrj_implicit_shardA_replica_n1/
   [junit4]   2> 2230853 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardA_replica_n1 
url=http://127.0.0.1:41713/solr START 
replicas=[http://127.0.0.1:40233/solr/solrj_implicit_shardA_replica_t2/] 
nUpdates=100
   [junit4]   2> 2230856 INFO  (qtp32796086-20453) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardB r:core_node11 x:solrj_implicit_shardB_replica_t8] 
o.a.s.c.S.Request [solrj_implicit_shardB_replica_t8]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2230860 INFO  (qtp10506257-20438) [n:127.0.0.1:40233_solr 
c:solrj_implicit s:shardA r:core_node5 x:solrj_implicit_shardA_replica_t2] 
o.a.s.c.S.Request [solrj_implicit_shardA_replica_t2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=3
   [junit4]   2> 2231153 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardB_replica_n7 
url=http://127.0.0.1:34513/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2231153 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2231153 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2231153 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2231154 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.u.PeerSync PeerSync: core=solrj_implicit_shardA_replica_n1 
url=http://127.0.0.1:41713/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 2231154 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 2231154 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 2231154 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 2231155 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:34513/solr/solrj_implicit_shardB_replica_n7/ shardB
   [junit4]   2> 2231156 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:41713/solr/solrj_implicit_shardA_replica_n1/ shardA
   [junit4]   2> 2231257 INFO  
(zkCallback-4758-thread-2-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4754-thread-1-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4754-thread-2-processing-n:127.0.0.1:35263_solr) 
[n:127.0.0.1:35263_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4753-thread-2-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4759-thread-1-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4753-thread-1-processing-n:127.0.0.1:40233_solr) 
[n:127.0.0.1:40233_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4758-thread-1-processing-n:127.0.0.1:41713_solr) 
[n:127.0.0.1:41713_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231257 INFO  
(zkCallback-4759-thread-3-processing-n:127.0.0.1:34513_solr) 
[n:127.0.0.1:34513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_implicit/state.json] for collection [solrj_implicit] 
has occurred - updating... (live nodes size: [4])
   [junit4]   2> 2231261 INFO  (indexFetcher-7203-thread-1) 
[n:127.0.0.1:40233_solr c:solrj_implicit s:shardB r:core_node12 
x:solrj_implicit_shardB_replica_p10] o.a.s.h.IndexFetcher Replica core_node9 is 
leader but it's state is down, skipping replication
   [junit4]   2> 2231297 INFO  (indexFetcher-7200-thread-1) 
[n:127.0.0.1:35263_solr c:solrj_implicit s:shardA r:core_node6 
x:solrj_implicit_shardA_replica_p4] o.a.s.h.IndexFetcher Replica core_node3 is 
leader but it's state is down, skipping replication
   [junit4]   2> 2231306 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2231306 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 2231315 INFO  (qtp6257815-20447) [n:127.0.0.1:34513_solr 
c:solrj_implicit s:shardB r:core_node9 x:solrj_implicit_shardB_replica_n7] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node9&collection.configName=conf&newCollection=true&name=solrj_implicit_shardB_replica_n7&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardB&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2383
   [junit4]   2> 2231315 INFO  (qtp32796086-20449) [n:127.0.0.1:41713_solr 
c:solrj_implicit s:shardA r:core_node3 x:solrj_implicit_shardA_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=solrj_implicit_shardA_replica_n1&action=CREATE&numShards=2&collection=solrj_implicit&shard=shardA&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2382
   [junit4]

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

leAdmin(HttpSolrCall.java:737)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:718)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:499)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: No registered 
leader was found after waiting for 1220000ms , collection: testSimple1 slice: 
shard2 saw state=null with live_nodes=[]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:816)
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.getLeaderUrl(ZkStateReader.java:781)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.getLeader(ZkController.java:1178)
   [junit4]   2>        ... 44 more
   [junit4]   2> 
   [junit4]   2> 3070964 INFO  (qtp31570732-29476) [n:127.0.0.1:44919_solr 
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=209748
   [junit4]   2> 3070965 ERROR 
(SUITE-AutoAddReplicasIntegrationTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 3070965 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[6A717A29D96C49C8]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:44257 44257
   [junit4]   2> 3084010 INFO  (Thread-7543) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:44257 44257
   [junit4]   2> 3084011 WARN  (Thread-7543) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/aliases.json
   [junit4]   2>        3       /solr/security.json
   [junit4]   2>        2       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/collections/testSimple1/state.json
   [junit4]   2>        4       /solr/clusterstate.json
   [junit4]   2>        4       /solr/clusterprops.json
   [junit4]   2>        2       
/solr/overseer_elect/election/98972414115119113-127.0.0.1:44919_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        4       /solr/live_nodes
   [junit4]   2>        4       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_6A717A29D96C49C8-001
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=27916, maxDocsPerChunk=358, blockSize=6), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=27916, blockSize=6)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@8d3f0b),
 locale=zh-HK, timezone=Etc/GMT+2
   [junit4]   2> NOTE: Linux 4.10.0-37-generic i386/Oracle Corporation 
1.8.0_144 (32-bit)/cpus=8,threads=1,free=101725464,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrQueryResponse, 
BlockJoinFacetSimpleTest, TestReversedWildcardFilterFactory, 
CachingDirectoryFactoryTest, DistanceUnitsTest, NodeMutatorTest, 
ChangedSchemaMergeTest, HdfsRestartWhileUpdatingTest, 
TestTolerantUpdateProcessorRandomCloud, TestJoin, SolrIndexMetricsTest, 
TestCodecSupport, NoCacheHeaderTest, DistribCursorPagingTest, SliceStateTest, 
ResponseLogComponentTest, LeaderElectionContextKeyTest, TestLegacyFieldCache, 
RulesTest, SpellCheckCollatorTest, TestSchemaSimilarityResource, 
SolrPluginUtilsTest, SystemLogListenerTest, TestFieldTypeResource, 
StatelessScriptUpdateProcessorFactoryTest, TestApiFramework, 
BaseCdcrDistributedZkTest, MoveReplicaHDFSTest, HdfsNNFailoverTest, 
TestCrossCoreJoin, ExplicitHLLTest, TestLRUStatsCache, TestUtils, 
TestCloudDeleteByQuery, TestCopyFieldCollectionResource, 
SolrCoreMetricManagerTest, TestManagedSchemaAPI, BasicDistributedZkTest, 
CdcrUpdateLogTest, TestStressLiveNodes, SoftAutoCommitTest, TestRandomFaceting, 
TestSolrIndexConfig, TestNamedUpdateProcessors, SimpleFacetsTest, 
CdcrVersionReplicationTest, PreAnalyzedFieldManagedSchemaCloudTest, 
TestSolrCloudSnapshots, SolrInfoBeanTest, TestWordDelimiterFilterFactory, 
HdfsDirectoryTest, TestSweetSpotSimilarityFactory, 
TestRuleBasedAuthorizationPlugin, VMParamsZkACLAndCredentialsProvidersTest, 
TestRandomRequestDistribution, TestNumericRangeQuery32, 
TestIndexingPerformance, DocValuesMissingTest, TestUninvertingReader, 
TestCustomDocTransformer, ConnectionManagerTest, BasicFunctionalityTest, 
TestHdfsUpdateLog, DocValuesTest, TestBulkSchemaConcurrent, 
TestXmlQParserPlugin, DirectUpdateHandlerOptimizeTest, ZkStateWriterTest, 
LeaderInitiatedRecoveryOnCommitTest, DistributedMLTComponentTest, 
CursorPagingTest, TestHdfsCloudBackupRestore, TestCorePropertiesReload, 
RAMDirectoryFactoryTest, IndexSchemaRuntimeFieldTest, 
ExternalFileFieldSortTest, SearchHandlerTest, TestSort, TestSimpleTextCodec, 
PeerSyncTest, TestCSVLoader, TestReplicationHandler, TestFastOutputStream, 
TestSkipOverseerOperations, UpdateParamsTest, CursorMarkTest, 
TestTestInjection, BJQParserTest, ZkControllerTest, DateMathParserTest, 
DocExpirationUpdateProcessorFactoryTest, StressHdfsTest, TestRecovery, 
TestPostingsSolrHighlighter, V2ApiIntegrationTest, 
TestMinMaxOnMultiValuedField, FacetPivotSmallTest, TestMultiWordSynonyms, 
TestSuggestSpellingConverter, TestSubQueryTransformerCrossCore, BasicZkTest, 
AutoAddReplicasPlanActionTest, TestFieldCollectionResource, 
TestCollectionsAPIViaSolrCloudCluster, MultiTermTest, TestIBSimilarityFactory, 
SyncSliceTest, ActionThrottleTest, InfoHandlerTest, TestMergePolicyConfig, 
TestUseDocValuesAsStored2, TestFoldingMultitermQuery, SpatialFilterTest, 
CheckHdfsIndexTest, TestObjectReleaseTracker, NodeAddedTriggerTest, 
BigEndianAscendingWordDeserializerTest, 
HdfsTlogReplayBufferedWhileIndexingTest, TestRequestForwarding, JsonLoaderTest, 
TestBinaryField, TestPayloadCheckQParserPlugin, DocumentBuilderTest, 
OverseerTaskQueueTest, ReplaceNodeTest, ReplicationFactorTest, 
RollingRestartTest, SharedFSAutoReplicaFailoverTest, 
SimpleCollectionCreateDeleteTest, TestCloudInspectUtil, 
TestCloudJSONFacetJoinDomain, TestClusterProperties, 
TestConfigSetsAPIZkFailure, TestDistribDocBasedVersion, 
TestLeaderElectionWithEmptyReplica, TestOnReconnectListenerSupport, 
TestPullReplica, TestRequestStatusCollectionAPI, 
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, 
TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, 
AutoAddReplicasIntegrationTest]
   [junit4] Completed [603/749 (2!)] on J0 in 223.75s, 1 test, 1 error <<< 
FAILURES!

[...truncated 43561 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to