You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/10/14 12:09:01 UTC
[JENKINS] Lucene-Solr-6.6-Windows (64bit/jdk1.8.0_144) - Build # 63
- Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.6-Windows/63/
Java: 64bit/jdk1.8.0_144 -XX:-UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Something is broken in the assert for no shards using the same indexDir - probably something was changed in the attributes published in the MBean of SolrCore : {}
Stack Trace:
java.lang.AssertionError: Something is broken in the assert for no shards using the same indexDir - probably something was changed in the attributes published in the MBean of SolrCore : {}
at __randomizedtesting.SeedInfo.seed([FD0C192A3D38297E:B5796D9E3B0B06EB]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.checkNoTwoShardsUseTheSameIndexDir(CollectionsAPIDistributedZkTest.java:646)
at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:524)
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)
FAILED: org.apache.solr.core.ExitableDirectoryReaderTest.testQueryResults
Error Message:
Should NOT have inserted partial results! expected:<5> but was:<6>
Stack Trace:
java.lang.AssertionError: Should NOT have inserted partial results! expected:<5> but was:<6>
at __randomizedtesting.SeedInfo.seed([FD0C192A3D38297E:A08521539F337735]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.core.ExitableDirectoryReaderTest.testQueryResults(ExitableDirectoryReaderTest.java:141)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12172 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\init-core-data-001
[junit4] 2> 1363575 WARN (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=46 numCloses=46
[junit4] 2> 1363575 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 1363580 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1363583 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001
[junit4] 2> 1363583 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1363584 INFO (Thread-2778) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1363584 INFO (Thread-2778) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1363587 ERROR (Thread-2778) [ ] 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> 1363683 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:63572
[junit4] 2> 1363693 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 0x15f1aa7b8f50000, 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> 1363700 INFO (jetty-launcher-2489-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1363700 INFO (jetty-launcher-2489-thread-3) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1363701 INFO (jetty-launcher-2489-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2f070197{/solr,null,AVAILABLE}
[junit4] 2> 1363707 INFO (jetty-launcher-2489-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1363708 INFO (jetty-launcher-2489-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7520168a{/solr,null,AVAILABLE}
[junit4] 2> 1363710 INFO (jetty-launcher-2489-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7351f278{/solr,null,AVAILABLE}
[junit4] 2> 1363713 INFO (jetty-launcher-2489-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2227fe77{SSL,[ssl, http/1.1]}{127.0.0.1:63576}
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.e.j.s.Server Started @1368183ms
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63576}
[junit4] 2> 1363714 ERROR (jetty-launcher-2489-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.6.2
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1363714 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-14T11:32:00.500Z
[junit4] 2> 1363716 INFO (jetty-launcher-2489-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6f3a1efe{SSL,[ssl, http/1.1]}{127.0.0.1:63582}
[junit4] 2> 1363716 INFO (jetty-launcher-2489-thread-3) [ ] o.e.j.s.Server Started @1368186ms
[junit4] 2> 1363716 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63582}
[junit4] 2> 1363717 ERROR (jetty-launcher-2489-thread-3) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1363717 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.6.2
[junit4] 2> 1363717 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1363717 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1363717 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-14T11:32:00.503Z
[junit4] 2> 1363719 INFO (jetty-launcher-2489-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@357d1b63{SSL,[ssl, http/1.1]}{127.0.0.1:63579}
[junit4] 2> 1363719 INFO (jetty-launcher-2489-thread-1) [ ] o.e.j.s.Server Started @1368190ms
[junit4] 2> 1363720 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63579}
[junit4] 2> 1363720 ERROR (jetty-launcher-2489-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1363720 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.6.2
[junit4] 2> 1363720 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1363720 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1363720 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-14T11:32:00.506Z
[junit4] 2> 1363740 INFO (jetty-launcher-2489-thread-4) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1363740 INFO (jetty-launcher-2489-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@434477a5{/solr,null,AVAILABLE}
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@10e6787e{SSL,[ssl, http/1.1]}{127.0.0.1:63594}
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.e.j.s.Server Started @1368212ms
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63594}
[junit4] 2> 1363742 ERROR (jetty-launcher-2489-thread-4) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.6.2
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1363742 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-14T11:32:00.528Z
[junit4] 2> 1363744 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1363746 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1363751 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1363765 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1363766 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1363769 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1363770 INFO (jetty-launcher-2489-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63572/solr
[junit4] 2> 1363771 INFO (jetty-launcher-2489-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63572/solr
[junit4] 2> 1363773 INFO (jetty-launcher-2489-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63572/solr
[junit4] 2> 1363777 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1363785 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1363786 INFO (jetty-launcher-2489-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63572/solr
[junit4] 2> 1363845 INFO (jetty-launcher-2489-thread-3) [n:127.0.0.1:63582_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1363846 INFO (jetty-launcher-2489-thread-2) [n:127.0.0.1:63576_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1363847 INFO (jetty-launcher-2489-thread-3) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63582_solr
[junit4] 2> 1363849 INFO (jetty-launcher-2489-thread-2) [n:127.0.0.1:63576_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63576_solr
[junit4] 2> 1363850 INFO (jetty-launcher-2489-thread-3) [n:127.0.0.1:63582_solr ] o.a.s.c.Overseer Overseer (id=98827024490364938-127.0.0.1:63582_solr-n_0000000000) starting
[junit4] 2> 1363862 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1363862 INFO (zkCallback-2509-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1363882 INFO (jetty-launcher-2489-thread-3) [n:127.0.0.1:63582_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63582_solr
[junit4] 2> 1363927 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1363927 INFO (zkCallback-2509-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1363971 INFO (jetty-launcher-2489-thread-3) [n:127.0.0.1:63582_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node3\.
[junit4] 2> 1363977 INFO (jetty-launcher-2489-thread-1) [n:127.0.0.1:63579_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1363978 INFO (jetty-launcher-2489-thread-1) [n:127.0.0.1:63579_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1363980 INFO (jetty-launcher-2489-thread-1) [n:127.0.0.1:63579_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63579_solr
[junit4] 2> 1363983 INFO (zkCallback-2510-thread-1-processing-n:127.0.0.1:63579_solr) [n:127.0.0.1:63579_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1363983 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1363998 INFO (zkCallback-2509-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1364050 INFO (jetty-launcher-2489-thread-4) [n:127.0.0.1:63594_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1364052 INFO (jetty-launcher-2489-thread-4) [n:127.0.0.1:63594_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1364053 INFO (jetty-launcher-2489-thread-4) [n:127.0.0.1:63594_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63594_solr
[junit4] 2> 1364077 INFO (zkCallback-2510-thread-1-processing-n:127.0.0.1:63579_solr) [n:127.0.0.1:63579_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1364077 INFO (zkCallback-2509-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1364077 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1364077 INFO (zkCallback-2511-thread-1-processing-n:127.0.0.1:63594_solr) [n:127.0.0.1:63594_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1364089 INFO (jetty-launcher-2489-thread-2) [n:127.0.0.1:63576_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node2\.
[junit4] 2> 1364140 INFO (jetty-launcher-2489-thread-4) [n:127.0.0.1:63594_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node4\.
[junit4] 2> 1364141 INFO (jetty-launcher-2489-thread-1) [n:127.0.0.1:63579_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node1\.
[junit4] 2> 1364167 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 0x15f1aa7b8f5000d, 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> 1364171 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1364172 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63572/solr ready
[junit4] 2> 1364248 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateShouldFailOnExistingCore
[junit4] 2> 1364251 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1364282 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CoreAdminOperation core create command dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-002&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2
[junit4] 2> 1364285 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1364291 INFO (OverseerStateUpdate-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1365316 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.2
[junit4] 2> 1365342 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 1365348 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1365348 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using configuration from collection halfcollectionblocker, trusted=true
[junit4] 2> 1365348 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1365348 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [[halfcollection_shard1_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node3\halfcollection_shard1_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-002\]
[junit4] 2> 1365439 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1365439 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1365440 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1365440 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1365441 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c780af9[halfcollection_shard1_replica1] main]
[junit4] 2> 1365442 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1365443 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1365443 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1365443 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1581232393791995904
[junit4] 2> 1365443 INFO (searcherExecutor-5565-thread-1-processing-n:127.0.0.1:63582_solr x:halfcollection_shard1_replica1 c:halfcollectionblocker) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [halfcollection_shard1_replica1] Registered new searcher Searcher@6c780af9[halfcollection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:63582/solr/halfcollection_shard1_replica1/
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:63582/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 1365450 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1365454 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:63582/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 1365608 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1365611 INFO (qtp506487542-14138) [n:127.0.0.1:63582_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-002&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2} status=0 QTime=1328
[junit4] 2> 1365644 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr ] o.a.s.h.a.CoreAdminOperation core create command dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2
[junit4] 2> 1365645 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1365650 INFO (OverseerStateUpdate-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1366709 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.2
[junit4] 2> 1366735 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 1366742 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1366742 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using configuration from collection halfcollectionblocker2, trusted=true
[junit4] 2> 1366743 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1366743 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [[halfcollection_shard1_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node2\halfcollection_shard1_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-003\]
[junit4] 2> 1366904 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1366904 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1366906 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1366906 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1366907 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@768b73c[halfcollection_shard1_replica1] main]
[junit4] 2> 1366908 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1366908 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1366908 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1366908 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1581232395328159744
[junit4] 2> 1366908 INFO (searcherExecutor-5570-thread-1-processing-n:127.0.0.1:63576_solr x:halfcollection_shard1_replica1 c:halfcollectionblocker2) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [halfcollection_shard1_replica1] Registered new searcher Searcher@768b73c[halfcollection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1366922 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1366922 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1366922 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:63576/solr/halfcollection_shard1_replica1/
[junit4] 2> 1366923 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1366923 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:63576/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 1366923 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1366930 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:63576/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 1367083 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1367084 INFO (qtp1500597157-14123) [n:127.0.0.1:63576_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2} status=0 QTime=1440
[junit4] 2> 1367095 INFO (qtp506487542-14155) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=halfcollection&action=CREATE&numShards=2&createNodeSet=127.0.0.1:63582_solr,127.0.0.1:63576_solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1367101 INFO (OverseerThreadFactory-5562-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Create collection halfcollection
[junit4] 2> 1367326 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard2_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard2&wt=javabin&version=2
[junit4] 2> 1367326 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard1_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard1&wt=javabin&version=2
[junit4] 2> 1367328 WARN (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 1367331 ERROR (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Core with name 'halfcollection_shard1_replica1' already exists.
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:839)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:748)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:729)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:510)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:361)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:305)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:136)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1367333 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard1_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard1&wt=javabin&version=2} status=500 QTime=8
[junit4] 2> 1367333 ERROR (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: Core with name 'halfcollection_shard1_replica1' already exists.
[junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:839)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:388)
[junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:173)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:748)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:729)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:510)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:361)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:305)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:136)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1367335 ERROR (OverseerThreadFactory-5562-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Error from shard: https://127.0.0.1:63582/solr
[junit4] 2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:63582/solr: Core with name 'halfcollection_shard1_replica1' already exists.
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:612)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
[junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:163)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1367447 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/halfcollection/state.json] for collection [halfcollection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1368387 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.2
[junit4] 2> 1368397 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.IndexSchema [halfcollection_shard2_replica1] Schema name=minimal
[junit4] 2> 1368403 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1368403 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard2_replica1' using configuration from collection halfcollection, trusted=true
[junit4] 2> 1368404 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1368404 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore [[halfcollection_shard2_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node2\halfcollection_shard2_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node2\.\halfcollection_shard2_replica1\data\]
[junit4] 2> 1368516 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1368516 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1368517 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1368517 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1368518 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@64ecaeeb[halfcollection_shard2_replica1] main]
[junit4] 2> 1368519 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1368520 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1368520 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1368520 INFO (searcherExecutor-5575-thread-1-processing-n:127.0.0.1:63576_solr x:halfcollection_shard2_replica1 s:shard2 c:halfcollection) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore [halfcollection_shard2_replica1] Registered new searcher Searcher@64ecaeeb[halfcollection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1368520 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1581232397018464256
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:63576/solr/halfcollection_shard2_replica1/
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:63576/solr/halfcollection_shard2_replica1/ has no replicas
[junit4] 2> 1368529 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1368534 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:63576/solr/halfcollection_shard2_replica1/ shard2
[junit4] 2> 1368641 INFO (zkCallback-2508-thread-1-processing-n:127.0.0.1:63576_solr) [n:127.0.0.1:63576_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/halfcollection/state.json] for collection [halfcollection] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1368689 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1368693 INFO (qtp1500597157-14154) [n:127.0.0.1:63576_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard2_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard2&wt=javabin&version=2} status=0 QTime=1367
[junit4] 2> 1368693 ERROR (OverseerThreadFactory-5562-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Cleaning up collection [halfcollection].
[junit4] 2> 1368694 INFO (OverseerThreadFactory-5562-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1368699 INFO (qtp1500597157-14117) [n:127.0.0.1:63576_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection.shard2.replica1
[junit4] 2> 1368699 INFO (qtp1500597157-14117) [n:127.0.0.1:63576_solr ] o.a.s.c.SolrCore [halfcollection_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@5f746c95
[junit4] 2> 1368699 INFO (qtp1500597157-14117) [n:127.0.0.1:63576_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection.shard2.replica1
[junit4] 2> 1368708 INFO (qtp1500597157-14117) [n:127.0.0.1:63576_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=halfcollection_shard2_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=10
[junit4] 2> 1369414 INFO (OverseerThreadFactory-5562-thread-1-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Cleaned up artifacts for failed create collection for [halfcollection]
[junit4] 2> 1369418 INFO (qtp506487542-14155) [n:127.0.0.1:63582_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> 1371105 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1399454 ERROR (qtp506487542-14155) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas to become ACTIVE with timeout=30
[junit4] 2> 1399454 INFO (qtp506487542-14155) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=halfcollection&action=CREATE&numShards=2&createNodeSet=127.0.0.1:63582_solr,127.0.0.1:63576_solr&wt=javabin&version=2} status=0 QTime=32358
[junit4] 2> 1399455 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateShouldFailOnExistingCore
[junit4] 2> 1399510 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting deleteCollectionRemovesStaleZkCollectionsNode
[junit4] 2> 1399512 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1399515 INFO (qtp506487542-14139) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=halfcollectionblocker2&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1399519 INFO (OverseerThreadFactory-5562-thread-2-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1399529 INFO (qtp1500597157-14119) [n:127.0.0.1:63576_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection_shard1_replica1
[junit4] 2> 1399529 INFO (qtp1500597157-14119) [n:127.0.0.1:63576_solr ] o.a.s.c.SolrCore [halfcollection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@31bf5f0d
[junit4] 2> 1399531 INFO (qtp1500597157-14119) [n:127.0.0.1:63576_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection_shard1_replica1
[junit4] 2> 1399536 INFO (qtp1500597157-14119) [n:127.0.0.1:63576_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=halfcollection_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=9
[junit4] 2> 1400244 INFO (qtp506487542-14139) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=halfcollectionblocker2&action=DELETE&wt=javabin&version=2} status=0 QTime=729
[junit4] 2> 1400247 INFO (qtp506487542-14137) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=halfcollectionblocker&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1400253 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1400260 INFO (OverseerThreadFactory-5562-thread-3-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1400271 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection_shard1_replica1
[junit4] 2> 1400271 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.c.SolrCore [halfcollection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@22b16d18
[junit4] 2> 1400271 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.halfcollection_shard1_replica1
[junit4] 2> 1400276 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=halfcollection_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=6
[junit4] 2> 1400987 INFO (qtp506487542-14137) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=halfcollectionblocker&action=DELETE&wt=javabin&version=2} status=0 QTime=738
[junit4] 2> 1400993 INFO (qtp506487542-14156) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=out_of_sync_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1400998 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1401005 INFO (qtp506487542-14156) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=out_of_sync_collection&action=DELETE&wt=javabin&version=2} status=0 QTime=11
[junit4] 2> 1401011 INFO (qtp506487542-14157) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1401011 INFO (qtp506487542-14157) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1401018 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending deleteCollectionRemovesStaleZkCollectionsNode
[junit4] 2> 1401077 INFO (TEST-CollectionsAPIDistributedZkTest.testCreationAndDeletion-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreationAndDeletion
[junit4] 2> 1401078 INFO (TEST-CollectionsAPIDistributedZkTest.testCreationAndDeletion-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1401080 INFO (qtp506487542-14157) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=created_and_deleted&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1401082 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1401084 INFO (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Create collection created_and_deleted
[junit4] 2> 1401326 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=created_and_deleted_shard1_replica1&action=CREATE&numShards=1&collection=created_and_deleted&shard=shard1&wt=javabin&version=2
[junit4] 2> 1401328 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1401438 INFO (zkCallback-2511-thread-1-processing-n:127.0.0.1:63594_solr) [n:127.0.0.1:63594_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/created_and_deleted/state.json] for collection [created_and_deleted] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1402379 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.2
[junit4] 2> 1402391 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.s.IndexSchema [created_and_deleted_shard1_replica1] Schema name=minimal
[junit4] 2> 1402399 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1402399 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'created_and_deleted_shard1_replica1' using configuration from collection created_and_deleted, trusted=true
[junit4] 2> 1402400 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1402400 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SolrCore [[created_and_deleted_shard1_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node4\created_and_deleted_shard1_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionsAPIDistributedZkTest_FD0C192A3D38297E-001\tempDir-001\node4\.\created_and_deleted_shard1_replica1\data\]
[junit4] 2> 1402608 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1402608 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1402610 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1402610 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1402614 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@482bf379[created_and_deleted_shard1_replica1] main]
[junit4] 2> 1402617 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 1402617 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1402618 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1402618 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1581232432772808704
[junit4] 2> 1402630 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1402631 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1402631 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:63594/solr/created_and_deleted_shard1_replica1/
[junit4] 2> 1402631 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1402631 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SyncStrategy https://127.0.0.1:63594/solr/created_and_deleted_shard1_replica1/ has no replicas
[junit4] 2> 1402631 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 1402638 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:63594/solr/created_and_deleted_shard1_replica1/ shard1
[junit4] 2> 1402640 INFO (searcherExecutor-5580-thread-1-processing-n:127.0.0.1:63594_solr x:created_and_deleted_shard1_replica1 s:shard1 c:created_and_deleted) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.SolrCore [created_and_deleted_shard1_replica1] Registered new searcher Searcher@482bf379[created_and_deleted_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1402741 INFO (zkCallback-2511-thread-1-processing-n:127.0.0.1:63594_solr) [n:127.0.0.1:63594_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/created_and_deleted/state.json] for collection [created_and_deleted] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1402742 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1402744 INFO (qtp494860494-14168) [n:127.0.0.1:63594_solr c:created_and_deleted s:shard1 x:created_and_deleted_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=created_and_deleted_shard1_replica1&action=CREATE&numShards=1&collection=created_and_deleted&shard=shard1&wt=javabin&version=2} status=0 QTime=1417
[junit4] 2> 1402747 INFO (qtp506487542-14157) [n:127.0.0.1:63582_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> 1402849 INFO (zkCallback-2511-thread-1-processing-n:127.0.0.1:63594_solr) [n:127.0.0.1:63594_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/created_and_deleted/state.json] for collection [created_and_deleted] has occurred - updating... (live nodes size: [4])
[junit4] 2> 1403086 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000008 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1403749 INFO (qtp506487542-14157) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=created_and_deleted&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2669
[junit4] 2> 1403754 INFO (qtp506487542-14139) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1403755 INFO (qtp506487542-14139) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1403756 INFO (qtp506487542-14155) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=created_and_deleted&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1403760 INFO (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1403768 INFO (qtp494860494-14170) [n:127.0.0.1:63594_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.created_and_deleted.shard1.replica1
[junit4] 2> 1403768 INFO (qtp494860494-14170) [n:127.0.0.1:63594_solr ] o.a.s.c.SolrCore [created_and_deleted_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@196c5ff5
[junit4] 2> 1403770 INFO (qtp494860494-14170) [n:127.0.0.1:63594_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.created_and_deleted.shard1.replica1
[junit4] 2> 1403778 INFO (qtp494860494-14170) [n:127.0.0.1:63594_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=created_and_deleted_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=10
[junit4] 2> 1404486 INFO (qtp506487542-14155) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=created_and_deleted&action=DELETE&wt=javabin&version=2} status=0 QTime=728
[junit4] 2> 1404487 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1404487 INFO (qtp506487542-14140) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1404488 INFO (TEST-CollectionsAPIDistributedZkTest.testCreationAndDeletion-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreationAndDeletion
[junit4] 2> 1404553 INFO (TEST-CollectionsAPIDistributedZkTest.testMissingNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMissingNumShards
[junit4] 2> 1404556 INFO (TEST-CollectionsAPIDistributedZkTest.testMissingNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1404559 INFO (qtp506487542-14137) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1404564 INFO (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Create collection acollection
[junit4] 2> 1404565 ERROR (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: acollection operation: create failed:org.apache.solr.common.SolrException: numShards is a required param (when using CompositeId router).
[junit4] 2> at org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1404566 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000010 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1404582 INFO (qtp506487542-14137) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&wt=javabin&version=2} status=400 QTime=22
[junit4] 2> 1404582 INFO (TEST-CollectionsAPIDistributedZkTest.testMissingNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMissingNumShards
[junit4] 2> 1404657 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTooManyReplicas
[junit4] 2> 1404659 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1404663 INFO (qtp506487542-14156) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1404666 INFO (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Create collection collection
[junit4] 2> 1404667 WARN (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Specified replicationFactor of 10 on collection collection is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(4). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 1404667 ERROR (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: collection operation: create failed:org.apache.solr.common.SolrException: Cannot create collection collection. Value of maxShardsPerNode is 1, and the number of nodes currently live or live and part of your createNodeSet is 4. This allows a maximum of 4 to be created. Value of numShards is 2 and value of replicationFactor is 10. This requires 20 shards to be created (higher than the allowed number)
[junit4] 2> at org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:155)
[junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1404667 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000012 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1404673 INFO (qtp506487542-14156) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=10&collection.configName=conf&name=collection&action=CREATE&numShards=2&wt=javabin&version=2} status=400 QTime=11
[junit4] 2> 1404678 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTooManyReplicas
[junit4] 2> 1404748 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testZeroNumShards
[junit4] 2> 1404749 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1404752 INFO (qtp506487542-14143) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&numShards=0&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1404756 INFO (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.CreateCollectionCmd Create collection acollection
[junit4] 2> 1404757 ERROR (OverseerThreadFactory-5562-thread-5-processing-n:127.0.0.1:63582_solr) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: acollection operation: create failed:org.apache.solr.common.SolrException: numShards must be > 0
[junit4] 2> at org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:124)
[junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1404759 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000014 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1404767 INFO (qtp506487542-14143) [n:127.0.0.1:63582_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&numShards=0&wt=javabin&version=2} status=400 QTime=14
[junit4] 2> 1404768 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testZeroNumShards
[junit4] 2> 1404857 INFO (TEST-CollectionsAPIDistributedZkTest.testDeleteNonExistentCollection-seed#[FD0C192A3D38297E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteNonExistentCollection
[junit4] 2> 1404859 INFO (TEST-CollectionsAPIDistributedZkTest.testDeleteNonExistentCollection-seed#[FD0C192A3D38297E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1404863 INFO (qtp506487542-14157) [n:127.0.0.1:63582_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=unknown_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1404867 INFO (OverseerCollectionConfigSetProcessor-98827024490364938-127.0.0.1:63582_solr-n_0000000000) [n:127.0.0.1:63582_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000016 doe
[...truncated too long message...]
= null] for registry solr.node / com.codahale.metrics.MetricRegistry@10f44c4c
[junit4] 2> 2192612 INFO (SUITE-ExitableDirectoryReaderTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jvm
[junit4] 2> 2192612 INFO (SUITE-ExitableDirectoryReaderTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6df7733f: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@43b965a
[junit4] 2> 2192614 INFO (SUITE-ExitableDirectoryReaderTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.jetty
[junit4] 2> 2192614 INFO (SUITE-ExitableDirectoryReaderTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@311f4e57: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@8efcce2
[junit4] 2> 2192614 INFO (SUITE-ExitableDirectoryReaderTest-seed#[FD0C192A3D38297E]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2192615 INFO (coreCloseExecutor-9536-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@54698c91
[junit4] 2> 2192615 INFO (coreCloseExecutor-9536-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 2192615 INFO (coreCloseExecutor-9536-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@10f1c618: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@abeaa2f
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-6.6-Windows\solr\build\solr-core\test\J1\temp\solr.core.ExitableDirectoryReaderTest_FD0C192A3D38297E-001
[junit4] 2> Oct 14, 2017 11:45:49 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=1, maxDocsPerChunk=3, blockSize=874), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=1, blockSize=874)), sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=fr-BE, timezone=America/Swift_Current
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=206240432,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestDynamicLoading, ChaosMonkeySafeLeaderTest, TestHdfsCloudBackupRestore, HdfsNNFailoverTest, TestWriterPerf, ReplaceNodeTest, CircularListTest, TestZkChroot, PKIAuthenticationIntegrationTest, TestRealTimeGet, LukeRequestHandlerTest, TestSolrCloudWithSecureImpersonation, TestSolrConfigHandlerCloud, TestMultiWordSynonyms, AutoCommitTest, TestOverriddenPrefixQueryForCustomFieldType, TestDocSet, BasicAuthIntegrationTest, ChangedSchemaMergeTest, TestStressUserVersions, SuggesterWFSTTest, DeleteShardTest, ExternalFileFieldSortTest, DeleteInactiveReplicaTest, TestCodecSupport, TestPointFields, LeaderElectionContextKeyTest, TestGraphMLResponseWriter, DistribCursorPagingTest, RecoveryAfterSoftCommitTest, SortByFunctionTest, TestFreeTextSuggestions, TestSolrCoreSnapshots, HdfsWriteToMultipleCollectionsTest, TestJmxMonitoredMap, AsyncCallRequestStatusResponseTest, ExplicitHLLTest, TestSystemIdResolver, TestSimpleQParserPlugin, TestEmbeddedSolrServerSchemaAPI, StatsReloadRaceTest, DistributedFacetPivotWhiteBoxTest, TestStressInPlaceUpdates, SuggesterTSTTest, TestJsonFacetRefinement, TestLocalFSCloudBackupRestore, TestDFISimilarityFactory, JSONWriterTest, CurrencyFieldOpenExchangeTest, TestRestManager, TestComplexPhraseLeadingWildcard, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestSchemalessBufferedUpdates, SpellCheckComponentTest, LargeFieldTest, CSVRequestHandlerTest, OverseerTaskQueueTest, CoreAdminHandlerTest, TestPayloadScoreQParserPlugin, PreAnalyzedUpdateProcessorTest, SolrMetricsIntegrationTest, TestSha256AuthenticationProvider, WordBreakSolrSpellCheckerTest, TestShortCircuitedRequests, SearchHandlerTest, TestCloudNestedDocsSort, UtilsToolTest, TestMaxScoreQueryParser, DistanceFunctionTest, CdcrVersionReplicationTest, TolerantUpdateProcessorTest, ClusterStateTest, SecurityConfHandlerTest, TestLMDirichletSimilarityFactory, TestScoreJoinQPNoScore, TestRandomFaceting, TestSuggestSpellingConverter, TestBinaryResponseWriter, SimpleMLTQParserTest, TestCloudPseudoReturnFields, LeaderFailureAfterFreshStartTest, SuggestComponentTest, RestartWhileUpdatingTest, HighlighterConfigTest, AnalysisErrorHandlingTest, BinaryUpdateRequestHandlerTest, TemplateUpdateProcessorTest, TestXmlQParser, MultiThreadedOCPTest, TestCloudSchemaless, LoggingHandlerTest, HdfsLockFactoryTest, HdfsBasicDistributedZkTest, TestSchemaNameResource, TestExceedMaxTermLength, NotRequiredUniqueKeyTest, TestPHPSerializedResponseWriter, BlockCacheTest, TestFieldCollectionResource, CdcrBootstrapTest, TestSearchPerf, MBeansHandlerTest, TestLeaderElectionZkExpiry, UpdateLogTest, URLClassifyProcessorTest, TestZkAclsWithHadoopAuth, SolrInfoMBeanTest, TestRecovery, DistributedTermsComponentTest, TestManagedSchemaAPI, TestValueSourceCache, TestReRankQParserPlugin, OutOfBoxZkACLAndCredentialsProvidersTest, TestSortByMinMaxFunction, TestDynamicFieldCollectionResource, TestHdfsBackupRestoreCore, TestSolrCLIRunExample, TestSchemaSimilarityResource, TestDistribIDF, TestTolerantUpdateProcessorCloud, TermVectorComponentTest, ShardSplitTest, AtomicUpdatesTest, SharedFSAutoReplicaFailoverUtilsTest, SuggesterTest, TestConfigSetsAPIZkFailure, ForceLeaderTest, TestCloudManagedSchema, JsonLoaderTest, MinimalSchemaTest, TestDFRSimilarityFactory, HdfsRecoveryZkTest, TestSolrDeletionPolicy2, SolrCLIZkUtilsTest, SpellPossibilityIteratorTest, TestTrie, TestNRTOpen, TestShardHandlerFactory, TestSubQueryTransformerCrossCore, TestDownShardTolerantSearch, TestSimpleTrackingShardHandler, TestPKIAuthenticationPlugin, CacheHeaderTest, HighlighterMaxOffsetTest, DocValuesMissingTest, CleanupOldIndexTest, TestChildDocTransformer, TestObjectReleaseTracker, QueryResultKeyTest, CoreMergeIndexesAdminHandlerTest, ClassificationUpdateProcessorIntegrationTest, TestRandomFlRTGCloud, RuleEngineTest, FieldAnalysisRequestHandlerTest, TestFieldTypeCollectionResource, TestHalfAndHalfDocValues, TestMergePolicyConfig, TestCrossCoreJoin, TestIndexSearcher, TestCollectionAPIs, TestSolr4Spatial2, TestFieldCacheSanityChecker, CheckHdfsIndexTest, TestCloudDeleteByQuery, CoreAdminCreateDiscoverTest, LeaderElectionIntegrationTest, FullSolrCloudDistribCmdsTest, AddSchemaFieldsUpdateProcessorFactoryTest, DataDrivenBlockJoinTest, CoreSorterTest, TestDistributedGrouping, DistributedVersionInfoTest, BufferStoreTest, ZkCLITest, ShardRoutingCustomTest, TestFaceting, TestHashPartitioner, ZkControllerTest, TestJoin, TestRangeQuery, SolrCmdDistributorTest, QueryElevationComponentTest, TestSort, TestFiltering, DirectUpdateHandlerTest, ShowFileRequestHandlerTest, TestCoreDiscovery, SpellCheckCollatorTest, TestFoldingMultitermQuery, TestStressLucene, SpatialFilterTest, TestCSVLoader, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, TestSolrDeletionPolicy1, IndexBasedSpellCheckerTest, TestQueryTypes, TestOmitPositions, XmlUpdateRequestHandlerTest, DocumentBuilderTest, TestIndexingPerformance, RegexBoostProcessorTest, TestJmxIntegration, UpdateRequestProcessorFactoryTest, QueryParsingTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, SolrIndexConfigTest, TestConfig, OutputWriterTest, TestSolrCoreProperties, TestLuceneMatchVersion, TestCharFilters, SynonymTokenizerTest, EchoParamsTest, TestFastWriter, TimeZoneUtilsTest, ScriptEngineTest, ChaosMonkeyNothingIsSafeTest, TestHighlightDedupGrouping, TestTolerantSearch, TestPathTrie, TestJettySolrRunner, ConnectionReuseTest, CdcrReplicationHandlerTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, ConfigSetsAPITest, ConnectionManagerTest, CreateCollectionCleanupTest, DeleteNodeTest, DistribJoinFromCollectionTest, LeaderInitiatedRecoveryOnShardRestartTest, MissingSegmentRecoveryTest, NodeMutatorTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerRolesTest, PeerSyncReplicationTest, RollingRestartTest, SolrXmlInZkTest, TestAuthenticationFramework, TestCloudInspectUtil, TestCloudJSONFacetJoinDomain, TestCloudRecovery, TestCryptoKeys, TestDeleteCollectionOnDownNodes, TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterSSL, TestRebalanceLeaders, TestSolrCloudWithDelegationTokens, TlogReplayBufferedWhileIndexingTest, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZk2Test, HdfsChaosMonkeySafeLeaderTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, StressHdfsTest, TestClusterStateMutator, ZkStateReaderTest, ZkStateWriterTest, BlobRepositoryCloudTest, DirectoryFactoryTest, ExitableDirectoryReaderTest]
[junit4] Completed [556/713 (2!)] on J1 in 0.83s, 3 tests, 1 failure <<< FAILURES!
[...truncated 44003 lines...]