Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/952/

1 tests failed.
FAILED:  
org.apache.solr.cloud.TestMiniSolrCloudCluster.testCollectionCreateSearchDelete

Error Message:
Error from server at http://127.0.0.1:53497/solr: Could not fully remove 
collection: testcollection

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:53497/solr: Could not fully remove collection: 
testcollection
        at 
__randomizedtesting.SeedInfo.seed([3D93D264FFF74609:9E697CC1781FACAC]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:594)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:261)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:250)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:477)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:407)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1383)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1134)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1073)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:177)
        at 
org.apache.solr.cloud.TestMiniSolrCloudCluster.testCollectionCreateSearchDelete(TestMiniSolrCloudCluster.java:212)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12714 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestMiniSolrCloudCluster
   [junit4]   2> 1566029 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001
   [junit4]   2> 1566030 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1566030 INFO  (Thread-2844) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1566030 INFO  (Thread-2844) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1566039 ERROR (Thread-2844) [    ] 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> 1566130 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.ZkTestServer start zk server on port:33579
   [junit4]   2> 1566142 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1566142 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1566144 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7e3f793e{/solr,null,AVAILABLE}
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@74aab107{HTTP/1.1,[http/1.1]}{127.0.0.1:47785}
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.e.j.s.Server Started @1569535ms
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=47785}
   [junit4]   2> 1566145 ERROR (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.7.0
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1566145 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1566146 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-22T22:50:14.469Z
   [junit4]   2> 1566148 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1566149 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1566151 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@43a24dac{/solr,null,AVAILABLE}
   [junit4]   2> 1566151 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6ec8b5bf{HTTP/1.1,[http/1.1]}{127.0.0.1:36708}
   [junit4]   2> 1566151 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.e.j.s.Server Started @1569542ms
   [junit4]   2> 1566152 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36708}
   [junit4]   2> 1566152 ERROR (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1566152 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.7.0
   [junit4]   2> 1566152 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1566152 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1566152 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-22T22:50:14.475Z
   [junit4]   2> 1566154 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1566159 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2c38b24e{/solr,null,AVAILABLE}
   [junit4]   2> 1566159 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@210bdd7f{HTTP/1.1,[http/1.1]}{127.0.0.1:53694}
   [junit4]   2> 1566160 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.e.j.s.Server Started @1569550ms
   [junit4]   2> 1566160 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53694}
   [junit4]   2> 1566161 ERROR (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1566161 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.7.0
   [junit4]   2> 1566161 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1566161 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1566161 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-22T22:50:14.484Z
   [junit4]   2> 1566163 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1566165 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1566172 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1566190 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2bfeb887{/solr,null,AVAILABLE}
   [junit4]   2> 1566191 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@17581ed6{HTTP/1.1,[http/1.1]}{127.0.0.1:46482}
   [junit4]   2> 1566191 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.e.j.s.Server Started @1569581ms
   [junit4]   2> 1566191 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=46482}
   [junit4]   2> 1566191 ERROR (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1566191 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.7.0
   [junit4]   2> 1566192 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1566192 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1566192 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-22T22:50:14.515Z
   [junit4]   2> 1566193 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1566194 INFO  (jetty-launcher-1967-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33579/solr
   [junit4]   2> 1566203 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3ad2381c{/solr,null,AVAILABLE}
   [junit4]   2> 1566205 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1566207 INFO  (jetty-launcher-1967-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33579/solr
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7d586da2{HTTP/1.1,[http/1.1]}{127.0.0.1:60939}
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.e.j.s.Server Started @1569602ms
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60939}
   [junit4]   2> 1566212 ERROR (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.7.0
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1566212 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-22T22:50:14.535Z
   [junit4]   2> 1566213 INFO  (jetty-launcher-1967-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33579/solr
   [junit4]   2> 1566219 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1566246 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 0x15cd1ffb1d80008, 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> 1566247 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1566254 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1566259 INFO  (jetty-launcher-1967-thread-5) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33579/solr
   [junit4]   2> 1566268 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1566269 INFO  (jetty-launcher-1967-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33579/solr
   [junit4]   2> 1566304 INFO  (jetty-launcher-1967-thread-4) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1566305 INFO  (jetty-launcher-1967-thread-1) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1566307 INFO  (jetty-launcher-1967-thread-4) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:53694_solr
   [junit4]   2> 1566307 INFO  (jetty-launcher-1967-thread-2) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1566308 INFO  (jetty-launcher-1967-thread-1) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:47785_solr
   [junit4]   2> 1566309 INFO  (jetty-launcher-1967-thread-4) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.Overseer Overseer 
(id=98184188025896970-127.0.0.1:53694_solr-n_0000000000) starting
   [junit4]   2> 1566316 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1566319 INFO  
(zkCallback-1988-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1566319 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1566321 INFO  (jetty-launcher-1967-thread-3) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1566322 INFO  (jetty-launcher-1967-thread-2) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36708_solr
   [junit4]   2> 1566325 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1566325 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1566325 INFO  
(zkCallback-1988-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1566325 INFO  (jetty-launcher-1967-thread-5) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1566345 INFO  
(zkCallback-1995-thread-1-processing-n:127.0.0.1:60939_solr) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1566348 INFO  (jetty-launcher-1967-thread-3) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1566353 INFO  (jetty-launcher-1967-thread-3) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60939_solr
   [junit4]   2> 1566353 INFO  (jetty-launcher-1967-thread-5) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1566355 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1566356 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1566356 INFO  
(zkCallback-1988-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1566358 INFO  
(zkCallback-1995-thread-1-processing-n:127.0.0.1:60939_solr) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1566372 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1566375 INFO  (jetty-launcher-1967-thread-4) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53694_solr
   [junit4]   2> 1566378 INFO  (jetty-launcher-1967-thread-5) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46482_solr
   [junit4]   2> 1566380 INFO  
(zkCallback-1988-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1566380 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1566381 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1566381 INFO  
(zkCallback-1995-thread-1-processing-n:127.0.0.1:60939_solr) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1566381 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1566387 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (5)
   [junit4]   2> 1566387 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (5)
   [junit4]   2> 1566387 INFO  
(zkCallback-1995-thread-1-processing-n:127.0.0.1:60939_solr) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (5)
   [junit4]   2> 1566387 INFO  
(zkCallback-1988-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (5)
   [junit4]   2> 1566391 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (4) -> (5)
   [junit4]   2> 1566430 INFO  (jetty-launcher-1967-thread-2) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node2/.
   [junit4]   2> 1566456 INFO  (jetty-launcher-1967-thread-3) 
[n:127.0.0.1:60939_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node3/.
   [junit4]   2> 1566463 INFO  (jetty-launcher-1967-thread-5) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node5/.
   [junit4]   2> 1566472 INFO  (jetty-launcher-1967-thread-4) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node4/.
   [junit4]   2> 1566484 INFO  (jetty-launcher-1967-thread-1) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node1/.
   [junit4]   2> 1567270 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 0x15cd1ffb1d80011, 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> 1567273 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 1567275 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33579/solr 
ready
   [junit4]   2> 1567278 INFO  (qtp961767678-12422) [n:127.0.0.1:47785_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&property.solr.tests.ramBufferSizeMB=100&collection.configName=solrCloudCollectionConfig&property.solr.tests.useMergePolicyFactory=false&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection&action=CREATE&numShards=2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
 and sendToOCPQueue=true
   [junit4]   2> 1567281 INFO  
(OverseerThreadFactory-5391-thread-1-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
testStopAllStartAllCollection
   [junit4]   2> 1567395 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard2_replica1&action=CREATE&numShards=2&shard=shard2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
   [junit4]   2> 1567395 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard2_replica2&action=CREATE&numShards=2&shard=shard2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
   [junit4]   2> 1567395 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1567395 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard1_replica2&action=CREATE&numShards=2&shard=shard1&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
   [junit4]   2> 1567396 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1567396 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard1_replica1&action=CREATE&numShards=2&shard=shard1&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
   [junit4]   2> 1567396 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1567396 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1567510 INFO  
(zkCallback-1988-thread-2-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1567510 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1567510 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1567510 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1568416 WARN  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.Config Beginning with 
Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1568416 WARN  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.Config Beginning with 
Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1568417 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.7.0
   [junit4]   2> 1568417 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.7.0
   [junit4]   2> 1568430 WARN  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.Config Beginning with 
Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1568431 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.7.0
   [junit4]   2> 1568435 WARN  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.Config Beginning with 
Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1568437 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.7.0
   [junit4]   2> 1568445 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.s.IndexSchema 
[testStopAllStartAllCollection_shard2_replica1] Schema name=test
   [junit4]   2> 1568446 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.s.IndexSchema 
[testStopAllStartAllCollection_shard2_replica2] Schema name=test
   [junit4]   2> 1568447 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.s.IndexSchema 
[testStopAllStartAllCollection_shard1_replica2] Schema name=test
   [junit4]   2> 1568475 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.s.IndexSchema 
[testStopAllStartAllCollection_shard1_replica1] Schema name=test
   [junit4]   2> 1568615 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1568620 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1568622 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1568638 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.CoreContainer Creating 
SolrCore 'testStopAllStartAllCollection_shard2_replica2' using configuration 
from collection testStopAllStartAllCollection, trusted=true
   [junit4]   2> 1568638 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'testStopAllStartAllCollection_shard2_replica1' using configuration 
from collection testStopAllStartAllCollection, trusted=true
   [junit4]   2> 1568638 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1568638 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.SolrCore 
[[testStopAllStartAllCollection_shard2_replica2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node2/testStopAllStartAllCollection_shard2_replica2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node2/./testStopAllStartAllCollection_shard2_replica2/data/]
   [junit4]   2> 1568638 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.CoreContainer Creating 
SolrCore 'testStopAllStartAllCollection_shard1_replica2' using configuration 
from collection testStopAllStartAllCollection, trusted=true
   [junit4]   2> 1568638 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1568638 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SolrCore 
[[testStopAllStartAllCollection_shard2_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node1/testStopAllStartAllCollection_shard2_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node1/./testStopAllStartAllCollection_shard2_replica1/data/]
   [junit4]   2> 1568639 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1568639 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SolrCore 
[[testStopAllStartAllCollection_shard1_replica2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node4/testStopAllStartAllCollection_shard1_replica2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node4/./testStopAllStartAllCollection_shard1_replica2/data/]
   [junit4]   2> 1568639 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.JmxMonitoredMap JMX 
monitoring is enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@751e096d
   [junit4]   2> 1568639 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.JmxMonitoredMap JMX 
monitoring is enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@751e096d
   [junit4]   2> 1568639 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.JmxMonitoredMap JMX 
monitoring is enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@751e096d
   [junit4]   2> 1568651 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1568656 WARN  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.RequestHandlers 
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class 
= DumpRequestHandler,attributes = {initParams=a, name=/dump, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1568658 WARN  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.RequestHandlers 
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class 
= DumpRequestHandler,attributes = {initParams=a, name=/dump, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1568663 WARN  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.RequestHandlers 
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class 
= DumpRequestHandler,attributes = {initParams=a, name=/dump, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1568668 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'testStopAllStartAllCollection_shard1_replica1' using configuration 
from collection testStopAllStartAllCollection, trusted=true
   [junit4]   2> 1568669 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1568670 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.SolrCore 
[[testStopAllStartAllCollection_shard1_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node5/testStopAllStartAllCollection_shard1_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001/tempDir-001/node5/./testStopAllStartAllCollection_shard1_replica1/data/]
   [junit4]   2> 1568670 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.JmxMonitoredMap JMX 
monitoring is enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@751e096d
   [junit4]   2> 1568700 WARN  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.RequestHandlers 
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class 
= DumpRequestHandler,attributes = {initParams=a, name=/dump, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1568731 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1568731 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1568732 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1568732 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1568733 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@4cbe307c[testStopAllStartAllCollection_shard2_replica1] main]
   [junit4]   2> 1568734 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1568734 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1568734 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1568734 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1568735 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1568735 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1568735 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1568735 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1568735 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
   [junit4]   2> 1568736 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
   [junit4]   2> 1568736 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 1568738 INFO  
(searcherExecutor-5403-thread-1-processing-n:127.0.0.1:47785_solr 
x:testStopAllStartAllCollection_shard2_replica1 s:shard2 
c:testStopAllStartAllCollection) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard2_replica1] Registered new searcher 
Searcher@4cbe307c[testStopAllStartAllCollection_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1568738 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@40059e8f[testStopAllStartAllCollection_shard2_replica2] main]
   [junit4]   2> 1568738 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@51e2c246[testStopAllStartAllCollection_shard1_replica2] main]
   [junit4]   2> 1568738 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1570947011246555136
   [junit4]   2> 1568739 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
   [junit4]   2> 1568740 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
   [junit4]   2> 1568740 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
   [junit4]   2> 1568740 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 1568740 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
   [junit4]   2> 1568740 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 1568743 INFO  
(searcherExecutor-5404-thread-1-processing-n:127.0.0.1:53694_solr 
x:testStopAllStartAllCollection_shard1_replica2 s:shard1 
c:testStopAllStartAllCollection) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard1_replica2] Registered new searcher 
Searcher@51e2c246[testStopAllStartAllCollection_shard1_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1568744 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1570947011252846592
   [junit4]   2> 1568745 INFO  
(searcherExecutor-5402-thread-1-processing-n:127.0.0.1:36708_solr 
x:testStopAllStartAllCollection_shard2_replica2 s:shard2 
c:testStopAllStartAllCollection) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard2_replica2] Registered new searcher 
Searcher@40059e8f[testStopAllStartAllCollection_shard2_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1568746 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1570947011254943744
   [junit4]   2> 1568749 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoutin=9998ms
   [junit4]   2> 1568756 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1568756 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1568756 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1568757 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1568757 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1568758 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2cbf82d7[testStopAllStartAllCollection_shard1_replica1] main]
   [junit4]   2> 1568760 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
   [junit4]   2> 1568760 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
   [junit4]   2> 1568760 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 1568761 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:46482_solr 
x:testStopAllStartAllCollection_shard1_replica1 s:shard1 
c:testStopAllStartAllCollection) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard1_replica1] Registered new searcher 
Searcher@2cbf82d7[testStopAllStartAllCollection_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1568762 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1570947011271720960
   [junit4]   2> 1568862 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1568862 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1568862 INFO  
(zkCallback-1988-thread-2-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1568862 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569249 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1569249 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1569249 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/
   [junit4]   2> 1569250 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.PeerSync PeerSync: 
core=testStopAllStartAllCollection_shard2_replica1 
url=http://127.0.0.1:47785/solr START 
replicas=[http://127.0.0.1:36708/solr/testStopAllStartAllCollection_shard2_replica2/]
 nUpdates=100
   [junit4]   2> 1569250 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.PeerSync PeerSync: 
core=testStopAllStartAllCollection_shard2_replica1 
url=http://127.0.0.1:47785/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1569253 INFO  (qtp1878628123-12433) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.S.Request 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1569253 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SyncStrategy Leader's 
attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1569253 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
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> 1569253 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1569257 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1569257 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1569257 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:53694/solr/testStopAllStartAllCollection_shard1_replica2/
   [junit4]   2> 1569257 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.PeerSync PeerSync: 
core=testStopAllStartAllCollection_shard1_replica2 
url=http://127.0.0.1:53694/solr START 
replicas=[http://127.0.0.1:46482/solr/testStopAllStartAllCollection_shard1_replica1/]
 nUpdates=100
   [junit4]   2> 1569257 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.PeerSync PeerSync: 
core=testStopAllStartAllCollection_shard1_replica2 
url=http://127.0.0.1:53694/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 1569260 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.S.Request 
[testStopAllStartAllCollection_shard1_replica1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1569260 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SyncStrategy Leader's 
attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1569260 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
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> 1569260 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1569262 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/ 
shard2
   [junit4]   2> 1569269 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:53694/solr/testStopAllStartAllCollection_shard1_replica2/ 
shard1
   [junit4]   2> 1569373 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569373 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569373 INFO  
(zkCallback-1988-thread-2-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569373 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569413 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 1569416 INFO  (qtp961767678-12419) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard2_replica1&action=CREATE&numShards=2&shard=shard2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=2022
   [junit4]   2> 1569420 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 1569427 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard1_replica2&action=CREATE&numShards=2&shard=shard1&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=2031
   [junit4]   2> 1569530 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569530 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569530 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569530 INFO  
(zkCallback-1988-thread-2-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569754 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2  
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard2_replica2&action=CREATE&numShards=2&shard=shard2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=2359
   [junit4]   2> 1569769 INFO  (qtp897493012-12456) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1  
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={property.solr.tests.ramBufferSizeMB=100&qt=/admin/cores&collection.configName=solrCloudCollectionConfig&newCollection=true&property.solr.tests.useMergePolicyFactory=false&collection=testStopAllStartAllCollection&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection_shard1_replica1&action=CREATE&numShards=2&shard=shard1&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=2373
   [junit4]   2> 1569775 INFO  (qtp961767678-12422) [n:127.0.0.1:47785_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1569877 INFO  
(zkCallback-1984-thread-1-processing-n:127.0.0.1:47785_solr) 
[n:127.0.0.1:47785_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569877 INFO  
(zkCallback-1988-thread-2-processing-n:127.0.0.1:53694_solr) 
[n:127.0.0.1:53694_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569877 INFO  
(zkCallback-1985-thread-1-processing-n:127.0.0.1:36708_solr) 
[n:127.0.0.1:36708_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1569878 INFO  
(zkCallback-1994-thread-1-processing-n:127.0.0.1:46482_solr) 
[n:127.0.0.1:46482_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testStopAllStartAllCollection/state.json] for collection 
[testStopAllStartAllCollection] has occurred - updating... (live nodes size: 
[5])
   [junit4]   2> 1570775 INFO  (qtp961767678-12422) [n:127.0.0.1:47785_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=2&property.solr.tests.ramBufferSizeMB=100&collection.configName=solrCloudCollectionConfig&property.solr.tests.useMergePolicyFactory=false&property.solr.tests.useMergePolicy=true&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testStopAllStartAllCollection&action=CREATE&numShards=2&property.solr.tests.mergePolicy=org.apache.lucene.index.TieredMergePolicy&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=3497
   [junit4]   2> 1570783 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 1570785 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - 
collection: testStopAllStartAllCollection failOnTimeout:true timeout (sec):330
   [junit4]   1> -
   [junit4]   1> replica:core_node2 rstate:active live:true
   [junit4]   1> replica:core_node3 rstate:active live:true
   [junit4]   1> replica:core_node1 rstate:active live:true
   [junit4]   1> replica:core_node4 rstate:active live:true
   [junit4]   1> no one is recoverying
   [junit4]   2> 1570785 INFO  
(TEST-TestMiniSolrCloudCluster.testStopAllStartAll-seed#[3D93D264FFF74609]) [   
 ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: 
testStopAllStartAllCollection
   [junit4]   2> 1570793 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:53694/solr/testStopAllStartAllCollection_shard1_replica2/&wt=javabin&version=2}{add=[1
 (1570947013397184512)]} 0 1
   [junit4]   2> 1570794 INFO  (qtp61987980-12444) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica2]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1570947013397184512)]} 0 5
   [junit4]   2> 1570801 INFO  (qtp1878628123-12434) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&wt=javabin&version=2}{add=[2
 (1570947013404524544)]} 0 1
   [junit4]   2> 1570801 INFO  (qtp961767678-12420) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2 (1570947013404524544)]} 0 5
   [junit4]   2> 1570805 INFO  (qtp1878628123-12416) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&wt=javabin&version=2}{add=[3
 (1570947013411864576)]} 0 0
   [junit4]   2> 1570805 INFO  (qtp961767678-12421) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3 (1570947013411864576)]} 0 2
   [junit4]   2> 1570808 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570808 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5101c795
   [junit4]   2> 1570809 INFO  (qtp61987980-12446) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570809 INFO  (qtp61987980-12446) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@26f3216c
   [junit4]   2> 1570811 INFO  (qtp961767678-12415) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570811 INFO  (qtp961767678-12415) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@405e97ef
   [junit4]   2> 1570817 INFO  (qtp1878628123-12428) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570817 INFO  (qtp1878628123-12428) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@b3d1e62
   [junit4]   2> 1570883 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@42b97d65[testStopAllStartAllCollection_shard1_replica1] main]
   [junit4]   2> 1570894 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 1570897 INFO  
(searcherExecutor-5405-thread-1-processing-n:127.0.0.1:46482_solr 
x:testStopAllStartAllCollection_shard1_replica1 s:shard1 
c:testStopAllStartAllCollection r:core_node3) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard1_replica1] Registered new searcher 
Searcher@42b97d65[testStopAllStartAllCollection_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C1)))}
   [junit4]   2> 1570898 INFO  (qtp897493012-12467) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 89
   [junit4]   2> 1570898 INFO  (qtp961767678-12415) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@cec7a00[testStopAllStartAllCollection_shard2_replica1] main]
   [junit4]   2> 1570904 INFO  
(searcherExecutor-5403-thread-1-processing-n:127.0.0.1:47785_solr 
x:testStopAllStartAllCollection_shard2_replica1 s:shard2 
c:testStopAllStartAllCollection r:core_node1) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard2_replica1] Registered new searcher 
Searcher@cec7a00[testStopAllStartAllCollection_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C2)))}
   [junit4]   2> 1570905 INFO  (qtp961767678-12415) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 1570905 INFO  (qtp961767678-12415) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 93
   [junit4]   2> 1570915 INFO  (qtp1878628123-12428) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1574d356[testStopAllStartAllCollection_shard2_replica2] main]
   [junit4]   2> 1570916 INFO  (qtp61987980-12446) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@6c2d2e90[testStopAllStartAllCollection_shard1_replica2] main]
   [junit4]   2> 1570917 INFO  
(searcherExecutor-5402-thread-1-processing-n:127.0.0.1:36708_solr 
x:testStopAllStartAllCollection_shard2_replica2 s:shard2 
c:testStopAllStartAllCollection r:core_node4) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard2_replica2] Registered new searcher 
Searcher@1574d356[testStopAllStartAllCollection_shard2_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C2)))}
   [junit4]   2> 1570918 INFO  (qtp1878628123-12428) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 1570918 INFO  (qtp1878628123-12428) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 101
   [junit4]   2> 1570918 INFO  (qtp61987980-12446) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 1570918 INFO  
(searcherExecutor-5404-thread-1-processing-n:127.0.0.1:53694_solr 
x:testStopAllStartAllCollection_shard1_replica2 s:shard1 
c:testStopAllStartAllCollection r:core_node2) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.c.SolrCore 
[testStopAllStartAllCollection_shard1_replica2] Registered new searcher 
Searcher@6c2d2e90[testStopAllStartAllCollection_shard1_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.7.0):C1)))}
   [junit4]   2> 1570919 INFO  (qtp61987980-12446) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 110
   [junit4]   2> 1570919 INFO  (qtp961767678-12417) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={_stateVer_=testStopAllStartAllCollection:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 112
   [junit4]   2> 1570927 INFO  (qtp897493012-12449) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:53694/solr/testStopAllStartAllCollection_shard1_replica2/&wt=javabin&version=2}{add=[4
 (1570947013535596544)]} 0 2
   [junit4]   2> 1570928 INFO  (qtp61987980-12439) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard1_replica2]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4 (1570947013535596544)]} 0 6
   [junit4]   2> 1570935 INFO  (qtp1878628123-12429) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&wt=javabin&version=2}{add=[5
 (1570947013545033728)]} 0 1
   [junit4]   2> 1570936 INFO  (qtp961767678-12423) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5 (1570947013545033728)]} 0 6
   [junit4]   2> 1570939 INFO  (qtp1878628123-12433) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica2]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:47785/solr/testStopAllStartAllCollection_shard2_replica1/&wt=javabin&version=2}{add=[6
 (1570947013552373760)]} 0 0
   [junit4]   2> 1570940 INFO  (qtp961767678-12420) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[testStopAllStartAllCollection_shard2_replica1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6 (1570947013552373760)]} 0 2
   [junit4]   2> 1570943 INFO  (qtp61987980-12443) [n:127.0.0.1:53694_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node2 
x:testStopAllStartAllCollection_shard1_replica2] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570943 INFO  (qtp961767678-12422) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570943 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570943 INFO  (qtp961767678-12422) [n:127.0.0.1:47785_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node1 
x:testStopAllStartAllCollection_shard2_replica1] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@405e97ef
   [junit4]   2> 1570943 INFO  (qtp1878628123-12430) [n:127.0.0.1:36708_solr 
c:testStopAllStartAllCollection s:shard2 r:core_node4 
x:testStopAllStartAllCollection_shard2_replica2] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@b3d1e62
   [junit4]   2> 1570944 INFO  (qtp897493012-12450) [n:127.0.0.1:46482_solr 
c:testStopAllStartAllCollection s:shard1 r:core_node3 
x:testStopAllStartAllCollection_shard1_replica1] o.a.s.u.DirectUpdateHandler2 
start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1570944 INFO  (qtp897493012-12450) [n

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

it4]   2> 1629062 INFO  (jetty-closer-2084-thread-5) [    ] o.a.s.c.Overseer 
Overseer (id=98184192010289167-127.0.0.1:55014_solr-n_0000000000) closing
   [junit4]   2> 1629062 INFO  
(OverseerStateUpdate-98184192010289167-127.0.0.1:55014_solr-n_0000000000) 
[n:127.0.0.1:55014_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:55014_solr
   [junit4]   2> 1629063 INFO  
(zkCallback-2100-thread-1-processing-n:127.0.0.1:34894_solr) 
[n:127.0.0.1:34894_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (5) -> (3)
   [junit4]   2> 1629063 INFO  
(zkCallback-2110-thread-1-processing-n:127.0.0.1:55014_solr) 
[n:127.0.0.1:55014_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (5) -> (3)
   [junit4]   2> 1629064 INFO  
(zkCallback-2104-thread-1-processing-n:127.0.0.1:40426_solr) 
[n:127.0.0.1:40426_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (5) -> (3)
   [junit4]   2> 1629066 INFO  (jetty-closer-2084-thread-3) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1629066 INFO  (jetty-closer-2084-thread-2) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1629068 INFO  
(zkCallback-2100-thread-1-processing-n:127.0.0.1:34894_solr) 
[n:127.0.0.1:34894_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:34894_solr
   [junit4]   2> 1629068 INFO  
(zkCallback-2100-thread-2-processing-n:127.0.0.1:34894_solr) 
[n:127.0.0.1:34894_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (2)
   [junit4]   2> 1629068 INFO  
(zkCallback-2104-thread-1-processing-n:127.0.0.1:40426_solr) 
[n:127.0.0.1:40426_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (2)
   [junit4]   2> 1630562 WARN  
(zkCallback-2109-thread-2-processing-n:127.0.0.1:41860_solr) 
[n:127.0.0.1:41860_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1630562 WARN  
(zkCallback-2105-thread-1-processing-n:127.0.0.1:43905_solr) 
[n:127.0.0.1:43905_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1630563 INFO  (jetty-closer-2084-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@29d53408{/solr,null,UNAVAILABLE}
   [junit4]   2> 1630563 INFO  (jetty-closer-2084-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@23dcb974{/solr,null,UNAVAILABLE}
   [junit4]   2> 1630565 WARN  
(zkCallback-2110-thread-1-processing-n:127.0.0.1:55014_solr) 
[n:127.0.0.1:55014_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1630565 INFO  (jetty-closer-2084-thread-5) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@176a2216{/solr,null,UNAVAILABLE}
   [junit4]   2> 1630569 WARN  
(zkCallback-2100-thread-2-processing-n:127.0.0.1:34894_solr) 
[n:127.0.0.1:34894_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1630569 WARN  
(zkCallback-2104-thread-1-processing-n:127.0.0.1:40426_solr) 
[n:127.0.0.1:40426_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1630569 INFO  (jetty-closer-2084-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@24406094{/solr,null,UNAVAILABLE}
   [junit4]   2> 1630570 INFO  (jetty-closer-2084-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5e432034{/solr,null,UNAVAILABLE}
   [junit4]   2> 1630571 ERROR 
(TEST-TestMiniSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[3D93D264FFF74609])
 [    ] 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> 1630572 INFO  
(TEST-TestMiniSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[3D93D264FFF74609])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33638 33638
   [junit4]   2> 1630667 INFO  (Thread-3007) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33638 33638
   [junit4]   2> 1630668 WARN  (Thread-3007) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        7       /solr/clusterprops.json
   [junit4]   2>        5       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        2       
/solr/overseer_elect/election/98184192010289161-127.0.0.1:34894_solr-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/live_nodes
   [junit4]   2>        7       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestMiniSolrCloudCluster_3D93D264FFF74609-001
   [junit4]   2> Jun 22, 2017 10:51:18 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{multiDefault=Lucene50(blocksize=128), id_i1=Lucene50(blocksize=128), 
id=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
_version_=DocValuesFormat(name=Lucene54), 
intDefault=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Lucene54), 
intDvoDefault=DocValuesFormat(name=Memory), 
range_facet_l=DocValuesFormat(name=Lucene54), 
timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=518, 
maxMBSortInHeap=7.528118118940549, 
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=el-GR, 
timezone=Europe/Chisinau
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=107049520,total=524288000
   [junit4]   2> NOTE: All tests run in this JVM: [BlockJoinFacetDistribTest, 
TestPerFieldSimilarityWithDefaultOverride, SolrXmlInZkTest, TestExportWriter, 
SolrMetricsIntegrationTest, FieldAnalysisRequestHandlerTest, SOLR749Test, 
SubstringBytesRefFilterTest, HdfsLockFactoryTest, TestSolrJ, 
TestImplicitCoreProperties, ZkStateWriterTest, JSONWriterTest, 
TestAnalyzedSuggestions, HardAutoCommitTest, SuggesterWFSTTest, 
BasicDistributedZk2Test, DocValuesMultiTest, TestSchemaNameResource, 
LukeRequestHandlerTest, TestFieldCacheSortRandom, CdcrVersionReplicationTest, 
TestDistribIDF, TimeZoneUtilsTest, LeaderFailureAfterFreshStartTest, 
TestCollationField, HdfsTlogReplayBufferedWhileIndexingTest, TestSort, 
TestCloudInspectUtil, TestAnalyzeInfixSuggestions, CreateCollectionCleanupTest, 
CdcrReplicationDistributedZkTest, BadIndexSchemaTest, V2ApiIntegrationTest, 
DistributedFacetPivotLongTailTest, DeleteLastCustomShardedReplicaTest, 
DistributedExpandComponentTest, TestCoreDiscovery, 
TestTrackingShardHandlerFactory, TestMacroExpander, TestScoreJoinQPNoScore, 
TestHdfsBackupRestoreCore, RecoveryZkTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
ConcurrentDeleteAndCreateCollectionTest, CloudMLTQParserTest, 
TestSolrCloudWithKerberosAlt, TestRuleBasedAuthorizationPlugin, 
ShowFileRequestHandlerTest, PluginInfoTest, TestRequestStatusCollectionAPI, 
TestConfigSetImmutable, BooleanFieldTest, TestIndexSearcher, 
SolrCoreMetricManagerTest, TestWriterPerf, AutoCommitTest, UpdateLogTest, 
TestExtendedDismaxParser, DebugComponentTest, TestPayloadScoreQParserPlugin, 
TestConfig, TestLegacyFieldCache, CdcrUpdateLogTest, 
TestShortCircuitedRequests, TestRawTransformer, TestDistribDocBasedVersion, 
TestZkChroot, TestManagedResource, TestManagedSchemaAPI, 
DistributedSuggestComponentTest, CursorMarkTest, CachingDirectoryFactoryTest, 
TestManagedSynonymFilterFactory, TestGroupingSearch, 
TestGraphTermsQParserPlugin, StatsReloadRaceTest, TestDistributedMissingSort, 
TestNRTOpen, CollectionTooManyReplicasTest, ResponseHeaderTest, TestRecovery, 
DistribDocExpirationUpdateProcessorTest, TestUninvertingReader, 
TestSolrFieldCacheMBean, CircularListTest, XmlUpdateRequestHandlerTest, 
RequestLoggingTest, ReplicaListTransformerTest, TestRestoreCore, 
TestBinaryField, TestSmileRequest, SolrTestCaseJ4Test, RollingRestartTest, 
HttpPartitionTest, BlockDirectoryTest, TestSchemaVersionResource, 
TestCloudManagedSchema, TestMaxScoreQueryParser, TestReload, PrimUtilsTest, 
TestSolrQueryParser, TestCorePropertiesReload, TestUseDocValuesAsStored2, 
TestImpersonationWithHadoopAuth, TestJsonFacetRefinement, 
CoreMergeIndexesAdminHandlerTest, VMParamsZkACLAndCredentialsProvidersTest, 
GraphQueryTest, HdfsNNFailoverTest, SimpleFacetsTest, TestDFRSimilarityFactory, 
TestRebalanceLeaders, TestJmxMonitoredMap, TestTolerantSearch, SyncSliceTest, 
LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest, 
LeaderElectionTest, ZkSolrClientTest, TestDistributedSearch, 
TestIndexingPerformance, SolrPluginUtilsTest, 
UniqFieldsUpdateProcessorFactoryTest, TestPartialUpdateDeduplication, 
TestComponentsName, TestBinaryResponseWriter, TestLFUCache, 
AsyncCallRequestStatusResponseTest, CollectionReloadTest, CustomCollectionTest, 
DistributedVersionInfoTest, MoveReplicaTest, MultiThreadedOCPTest, 
SolrCLIZkUtilsTest, SolrCloudExampleTest, TestCloudPseudoReturnFields, 
TestCloudRecovery, TestLeaderElectionWithEmptyReplica, TestMiniSolrCloudCluster]
   [junit4] Completed [544/715 (1!)] on J2 in 64.91s, 3 tests, 1 error <<< 
FAILURES!

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

Reply via email to