Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3946/ Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI Error Message: Error from server at http://127.0.0.1:56230/solr/awhollynewcollection_0: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 510 </title> </head> <body> <h2>HTTP ERROR: 510</h2> <p>Problem accessing /solr/awhollynewcollection_0/select. Reason: <pre> {metadata={error-class=org.apache.solr.common.SolrException,root-error-class=org.apache.solr.common.SolrException},msg={"awhollynewcollection_0":5},code=510}</pre></p> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/> </body> </html> Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:56230/solr/awhollynewcollection_0: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 510 </title> </head> <body> <h2>HTTP ERROR: 510</h2> <p>Problem accessing /solr/awhollynewcollection_0/select. Reason: <pre> {metadata={error-class=org.apache.solr.common.SolrException,root-error-class=org.apache.solr.common.SolrException},msg={"awhollynewcollection_0":5},code=510}</pre></p> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/> </body> </html> at __randomizedtesting.SeedInfo.seed([EF81F54EA752694E:A7F481FAA16146DB]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:595) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:439) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:391) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1364) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1115) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1218) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1218) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1218) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1218) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1218) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1054) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:523) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11468 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/init-core-data-001 [junit4] 2> 875727 WARN (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 875727 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields [junit4] 2> 875730 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth [junit4] 2> 875731 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001 [junit4] 2> 875731 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 875732 INFO (Thread-1374) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 875732 INFO (Thread-1374) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 875841 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:56226 [junit4] 2> 875865 INFO (jetty-launcher-2220-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 875865 INFO (jetty-launcher-2220-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 875865 INFO (jetty-launcher-2220-thread-3) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 875866 INFO (jetty-launcher-2220-thread-4) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 875870 INFO (jetty-launcher-2220-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1dbd8d51{/solr,null,AVAILABLE} [junit4] 2> 875870 INFO (jetty-launcher-2220-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4887d3fb{/solr,null,AVAILABLE} [junit4] 2> 875871 INFO (jetty-launcher-2220-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4578d5f{/solr,null,AVAILABLE} [junit4] 2> 875871 INFO (jetty-launcher-2220-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3af526ed{HTTP/1.1,[http/1.1]}{127.0.0.1:56229} [junit4] 2> 875871 INFO (jetty-launcher-2220-thread-3) [ ] o.e.j.s.Server Started @880965ms [junit4] 2> 875871 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56229} [junit4] 2> 875872 ERROR (jetty-launcher-2220-thread-3) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 875872 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 875872 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 875872 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 875872 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-06T01:19:54.469Z [junit4] 2> 875873 INFO (jetty-launcher-2220-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4783b6c6{/solr,null,AVAILABLE} [junit4] 2> 875873 INFO (jetty-launcher-2220-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2f592d3{HTTP/1.1,[http/1.1]}{127.0.0.1:56230} [junit4] 2> 875873 INFO (jetty-launcher-2220-thread-4) [ ] o.e.j.s.Server Started @880967ms [junit4] 2> 875873 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56230} [junit4] 2> 875873 ERROR (jetty-launcher-2220-thread-4) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 875873 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 875874 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 875874 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 875874 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-06T01:19:54.471Z [junit4] 2> 875879 INFO (jetty-launcher-2220-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@39cb9455{HTTP/1.1,[http/1.1]}{127.0.0.1:56228} [junit4] 2> 875879 INFO (jetty-launcher-2220-thread-2) [ ] o.e.j.s.Server Started @880973ms [junit4] 2> 875879 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56228} [junit4] 2> 875879 ERROR (jetty-launcher-2220-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 875880 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 875880 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 875880 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 875880 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-06T01:19:54.477Z [junit4] 2> 875883 INFO (jetty-launcher-2220-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@634de947{HTTP/1.1,[http/1.1]}{127.0.0.1:56231} [junit4] 2> 875884 INFO (jetty-launcher-2220-thread-1) [ ] o.e.j.s.Server Started @880977ms [junit4] 2> 875884 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56231} [junit4] 2> 875884 ERROR (jetty-launcher-2220-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 875884 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 875885 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 875885 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 875885 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-06T01:19:54.482Z [junit4] 2> 875888 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 875890 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 875890 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 875891 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 875907 INFO (jetty-launcher-2220-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56226/solr [junit4] 2> 875907 INFO (jetty-launcher-2220-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56226/solr [junit4] 2> 875909 INFO (jetty-launcher-2220-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56226/solr [junit4] 2> 875910 INFO (jetty-launcher-2220-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56226/solr [junit4] 2> 875968 INFO (jetty-launcher-2220-thread-2) [n:127.0.0.1:56228_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 875969 INFO (jetty-launcher-2220-thread-3) [n:127.0.0.1:56229_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 875969 INFO (jetty-launcher-2220-thread-4) [n:127.0.0.1:56230_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 875969 INFO (jetty-launcher-2220-thread-1) [n:127.0.0.1:56231_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 875972 INFO (jetty-launcher-2220-thread-3) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56229_solr [junit4] 2> 875973 INFO (jetty-launcher-2220-thread-2) [n:127.0.0.1:56228_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56228_solr [junit4] 2> 875973 INFO (jetty-launcher-2220-thread-1) [n:127.0.0.1:56231_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56231_solr [junit4] 2> 875973 INFO (jetty-launcher-2220-thread-4) [n:127.0.0.1:56230_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56230_solr [junit4] 2> 875975 INFO (jetty-launcher-2220-thread-3) [n:127.0.0.1:56229_solr ] o.a.s.c.Overseer Overseer (id=97743116326076425-127.0.0.1:56229_solr-n_0000000000) starting [junit4] 2> 875977 INFO (zkCallback-2242-thread-1-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 875977 INFO (zkCallback-2240-thread-1-processing-n:127.0.0.1:56228_solr) [n:127.0.0.1:56228_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 875977 INFO (zkCallback-2239-thread-1-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 875977 INFO (zkCallback-2241-thread-1-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 876024 INFO (jetty-launcher-2220-thread-3) [n:127.0.0.1:56229_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56229_solr [junit4] 2> 876026 INFO (zkCallback-2240-thread-1-processing-n:127.0.0.1:56228_solr) [n:127.0.0.1:56228_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 876026 INFO (zkCallback-2241-thread-1-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 876027 INFO (zkCallback-2239-thread-1-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 876027 INFO (zkCallback-2242-thread-1-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 876104 INFO (jetty-launcher-2220-thread-2) [n:127.0.0.1:56228_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node1/. [junit4] 2> 876104 INFO (jetty-launcher-2220-thread-4) [n:127.0.0.1:56230_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node4/. [junit4] 2> 876110 INFO (jetty-launcher-2220-thread-3) [n:127.0.0.1:56229_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node2/. [junit4] 2> 876176 INFO (jetty-launcher-2220-thread-1) [n:127.0.0.1:56231_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node3/. [junit4] 2> 876883 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 876885 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56226/solr ready [junit4] 2> 876937 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet [junit4] 2> 876939 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 876945 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=http://127.0.0.1:56228/solr,http://127.0.0.1:56229/solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 876950 INFO (OverseerThreadFactory-3277-thread-1-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection nodeset_collection [junit4] 2> 876951 WARN (OverseerThreadFactory-3277-thread-1-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd It is unusual to create a collection (nodeset_collection) without cores. [junit4] 2> 877064 INFO (qtp65102727-8728) [n:127.0.0.1:56228_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> 877064 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=http://127.0.0.1:56228/solr,http://127.0.0.1:56229/solr&wt=javabin&version=2} status=0 QTime=119 [junit4] 2> 877066 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet [junit4] 2> 877101 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateShouldFailOnExistingCore [junit4] 2> 877104 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 877108 INFO (qtp65102727-8729) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=nodeset_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 877113 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 877113 INFO (OverseerThreadFactory-3277-thread-2-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 877824 INFO (qtp65102727-8729) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=nodeset_collection&action=DELETE&wt=javabin&version=2} status=0 QTime=716 [junit4] 2> 877831 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr ] o.a.s.h.a.CoreAdminOperation core create command dataDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-002&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2 [junit4] 2> 877833 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 877836 INFO (OverseerStateUpdate-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 878864 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 878873 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal [junit4] 2> 878878 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 878878 INFO (qtp538759068-8755) [n:127.0.0.1:56231_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> 878878 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 878878 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [[halfcollection_shard1_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node3/halfcollection_shard1_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-002/] [junit4] 2> 878940 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 878940 INFO (qtp538759068-8755) [n:127.0.0.1:56231_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> 878943 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 878943 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 878944 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@349734fe[halfcollection_shard1_replica1] main] [junit4] 2> 878946 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 878946 INFO (qtp538759068-8755) [n:127.0.0.1:56231_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> 878946 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 878947 INFO (qtp538759068-8755) [n:127.0.0.1:56231_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 1563889864586297344 [junit4] 2> 878947 INFO (searcherExecutor-3286-thread-1-processing-n:127.0.0.1:56231_solr x:halfcollection_shard1_replica1 c:halfcollectionblocker) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [halfcollection_shard1_replica1] Registered new searcher Searcher@349734fe[halfcollection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56231/solr/halfcollection_shard1_replica1/ [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:56231/solr/halfcollection_shard1_replica1/ has no replicas [junit4] 2> 878958 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 878967 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56231/solr/halfcollection_shard1_replica1/ shard1 [junit4] 2> 879123 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 879123 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 879126 INFO (qtp538759068-8755) [n:127.0.0.1:56231_solr c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={dataDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-002&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2} status=0 QTime=1296 [junit4] 2> 879133 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CoreAdminOperation core create command dataDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2 [junit4] 2> 879133 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 879136 INFO (OverseerStateUpdate-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 880163 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 880170 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal [junit4] 2> 880175 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 880175 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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> 880176 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 880176 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [[halfcollection_shard1_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node1/halfcollection_shard1_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-003/] [junit4] 2> 880253 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 880253 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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> 880255 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 880255 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 880256 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@351d1aa3[halfcollection_shard1_replica1] main] [junit4] 2> 880259 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 880260 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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> 880260 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 880260 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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 1563889865963077632 [junit4] 2> 880260 INFO (searcherExecutor-3291-thread-1-processing-n:127.0.0.1:56228_solr x:halfcollection_shard1_replica1 c:halfcollectionblocker2) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore [halfcollection_shard1_replica1] Registered new searcher Searcher@351d1aa3[halfcollection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56228/solr/halfcollection_shard1_replica1/ [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:56228/solr/halfcollection_shard1_replica1/ has no replicas [junit4] 2> 880271 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 880280 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56228/solr/halfcollection_shard1_replica1/ shard1 [junit4] 2> 880450 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 880453 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={dataDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2} status=0 QTime=1320 [junit4] 2> 880454 INFO (qtp65102727-8732) [n:127.0.0.1:56228_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:56231_solr,127.0.0.1:56228_solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 880458 INFO (OverseerThreadFactory-3277-thread-3-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection halfcollection [junit4] 2> 880677 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 880678 INFO (qtp538759068-8756) [n:127.0.0.1:56231_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> 880679 WARN (qtp538759068-8756) [n:127.0.0.1:56231_solr ] o.a.s.c.CoreContainer Creating a core with existing name is not allowed [junit4] 2> 880681 ERROR (qtp538759068-8756) [n:127.0.0.1:56231_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:884) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370) [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:747) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) [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:139) [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.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:745) [junit4] 2> [junit4] 2> 880681 INFO (qtp538759068-8756) [n:127.0.0.1:56231_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=5 [junit4] 2> 880682 ERROR (qtp538759068-8756) [n:127.0.0.1:56231_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:884) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:370) [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:747) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:728) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:509) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298) [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:139) [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.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:745) [junit4] 2> [junit4] 2> 880682 ERROR (OverseerThreadFactory-3277-thread-3-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Error from shard: http://127.0.0.1:56231/solr [junit4] 2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:56231/solr: Core with name 'halfcollection_shard1_replica1' already exists. [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627) [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:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 880793 INFO (zkCallback-2240-thread-1-processing-n:127.0.0.1:56228_solr) [n:127.0.0.1:56228_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> 881708 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 881717 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.IndexSchema [halfcollection_shard2_replica1] Schema name=minimal [junit4] 2> 881721 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 881721 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 881722 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 881723 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore [[halfcollection_shard2_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node1/halfcollection_shard2_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node1/./halfcollection_shard2_replica1/data/] [junit4] 2> 881789 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 881789 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 881792 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 881792 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 881792 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2b08e8aa[halfcollection_shard2_replica1] main] [junit4] 2> 881794 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 881795 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 881795 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 881795 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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 1563889867572641792 [junit4] 2> 881795 INFO (searcherExecutor-3296-thread-1-processing-n:127.0.0.1:56228_solr x:halfcollection_shard2_replica1 s:shard2 c:halfcollection) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrCore [halfcollection_shard2_replica1] Registered new searcher Searcher@2b08e8aa[halfcollection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56228/solr/halfcollection_shard2_replica1/ [junit4] 2> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:56228/solr/halfcollection_shard2_replica1/ has no replicas [junit4] 2> 881806 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 881813 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56228/solr/halfcollection_shard2_replica1/ shard2 [junit4] 2> 881918 INFO (zkCallback-2240-thread-1-processing-n:127.0.0.1:56228_solr) [n:127.0.0.1:56228_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> 881919 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 881923 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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=1246 [junit4] 2> 881923 ERROR (OverseerThreadFactory-3277-thread-3-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Cleaning up collection [halfcollection]. [junit4] 2> 881925 INFO (OverseerThreadFactory-3277-thread-3-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 881937 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollection.shard2.replica1, tag=null [junit4] 2> 881938 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.c.SolrCore [halfcollection_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@78a32276 [junit4] 2> 881939 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollection.shard2.replica1, tag=2023957110 [junit4] 2> 881950 INFO (qtp65102727-8728) [n:127.0.0.1:56228_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=23 [junit4] 2> 882668 INFO (OverseerThreadFactory-3277-thread-3-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Cleaned up artifacts for failed create collection for [halfcollection] [junit4] 2> 882672 INFO (qtp65102727-8732) [n:127.0.0.1:56228_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> 884475 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 912805 ERROR (qtp65102727-8732) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas to become ACTIVE with timeout=30 [junit4] 2> 912806 INFO (qtp65102727-8732) [n:127.0.0.1:56228_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:56231_solr,127.0.0.1:56228_solr&wt=javabin&version=2} status=0 QTime=32351 [junit4] 2> 912806 INFO (TEST-CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateShouldFailOnExistingCore [junit4] 2> 912840 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionOnlyInZk-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting deleteCollectionOnlyInZk [junit4] 2> 912842 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionOnlyInZk-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 912845 INFO (qtp65102727-8729) [n:127.0.0.1:56228_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> 912851 INFO (OverseerThreadFactory-3277-thread-4-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 912858 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollectionblocker2.shard1.core_node1, tag=null [junit4] 2> 912858 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.c.SolrCore [halfcollection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@49b20447 [junit4] 2> 912860 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollectionblocker2.shard1.core_node1, tag=1236403271 [junit4] 2> 912863 INFO (qtp65102727-8730) [n:127.0.0.1:56228_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=5 [junit4] 2> 913587 INFO (qtp65102727-8729) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=halfcollectionblocker2&action=DELETE&wt=javabin&version=2} status=0 QTime=742 [junit4] 2> 913588 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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> 913592 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 913592 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 913595 INFO (qtp538759068-8758) [n:127.0.0.1:56231_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollectionblocker.shard1.core_node1, tag=null [junit4] 2> 913596 INFO (qtp538759068-8758) [n:127.0.0.1:56231_solr ] o.a.s.c.SolrCore [halfcollection_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@2b37cfea [junit4] 2> 913597 INFO (qtp538759068-8758) [n:127.0.0.1:56231_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.halfcollectionblocker.shard1.core_node1, tag=725077994 [junit4] 2> 913600 INFO (qtp538759068-8758) [n:127.0.0.1:56231_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=5 [junit4] 2> 914318 INFO (qtp65102727-8731) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=halfcollectionblocker&action=DELETE&wt=javabin&version=2} status=0 QTime=730 [junit4] 2> 914325 INFO (qtp65102727-8733) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=onlyinzk&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 914329 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 914336 INFO (qtp65102727-8733) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=onlyinzk&action=DELETE&wt=javabin&version=2} status=0 QTime=10 [junit4] 2> 914336 INFO (qtp65102727-8726) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 914336 INFO (qtp65102727-8726) [n:127.0.0.1:56228_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> 914337 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=onlyinzk&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 914341 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection onlyinzk [junit4] 2> 914342 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 914566 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=onlyinzk_shard1_replica1&action=CREATE&numShards=2&collection=onlyinzk&shard=shard1&wt=javabin&version=2 [junit4] 2> 914567 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=onlyinzk_shard2_replica1&action=CREATE&numShards=2&collection=onlyinzk&shard=shard2&wt=javabin&version=2 [junit4] 2> 914568 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 914678 INFO (zkCallback-2242-thread-1-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 914678 INFO (zkCallback-2241-thread-1-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 915600 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 915600 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 915609 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.s.IndexSchema [onlyinzk_shard1_replica1] Schema name=minimal [junit4] 2> 915609 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.s.IndexSchema [onlyinzk_shard2_replica1] Schema name=minimal [junit4] 2> 915630 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 915630 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'onlyinzk_shard1_replica1' using configuration from collection onlyinzk, trusted=true [junit4] 2> 915630 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 915630 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'onlyinzk_shard2_replica1' using configuration from collection onlyinzk, trusted=true [junit4] 2> 915630 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 915630 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 915631 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SolrCore [[onlyinzk_shard1_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node3/onlyinzk_shard1_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node3/./onlyinzk_shard1_replica1/data/] [junit4] 2> 915631 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SolrCore [[onlyinzk_shard2_replica1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node4/onlyinzk_shard2_replica1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001/tempDir-001/node4/./onlyinzk_shard2_replica1/data/] [junit4] 2> 915712 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 915712 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 915712 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 915712 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 915717 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 915717 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 915718 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 915718 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 915718 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@36df2d09[onlyinzk_shard1_replica1] main] [junit4] 2> 915718 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a70e0da[onlyinzk_shard2_replica1] main] [junit4] 2> 915720 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 915720 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 915721 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 915721 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 915721 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 915722 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 915722 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1563889903147679744 [junit4] 2> 915722 INFO (searcherExecutor-3301-thread-1-processing-n:127.0.0.1:56231_solr x:onlyinzk_shard1_replica1 s:shard1 c:onlyinzk) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SolrCore [onlyinzk_shard1_replica1] Registered new searcher Searcher@36df2d09[onlyinzk_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 915722 INFO (searcherExecutor-3302-thread-1-processing-n:127.0.0.1:56230_solr x:onlyinzk_shard2_replica1 s:shard2 c:onlyinzk) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SolrCore [onlyinzk_shard2_replica1] Registered new searcher Searcher@a70e0da[onlyinzk_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 915722 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1563889903147679744 [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56231/solr/onlyinzk_shard1_replica1/ [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:56231/solr/onlyinzk_shard1_replica1/ has no replicas [junit4] 2> 915733 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56230/solr/onlyinzk_shard2_replica1/ [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:56230/solr/onlyinzk_shard2_replica1/ has no replicas [junit4] 2> 915733 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 915740 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56231/solr/onlyinzk_shard1_replica1/ shard1 [junit4] 2> 915741 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56230/solr/onlyinzk_shard2_replica1/ shard2 [junit4] 2> 915851 INFO (zkCallback-2242-thread-1-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 915851 INFO (zkCallback-2241-thread-1-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 915905 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 915905 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 915910 INFO (qtp538759068-8759) [n:127.0.0.1:56231_solr c:onlyinzk s:shard1 x:onlyinzk_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=onlyinzk_shard1_replica1&action=CREATE&numShards=2&collection=onlyinzk&shard=shard1&wt=javabin&version=2} status=0 QTime=1345 [junit4] 2> 915910 INFO (qtp912984427-8737) [n:127.0.0.1:56230_solr c:onlyinzk s:shard2 x:onlyinzk_shard2_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=onlyinzk_shard2_replica1&action=CREATE&numShards=2&collection=onlyinzk&shard=shard2&wt=javabin&version=2} status=0 QTime=1343 [junit4] 2> 915916 INFO (qtp65102727-8728) [n:127.0.0.1:56228_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> 916021 INFO (zkCallback-2241-thread-1-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 916021 INFO (zkCallback-2242-thread-1-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/onlyinzk/state.json] for collection [onlyinzk] has occurred - updating... (live nodes size: [4]) [junit4] 2> 916348 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 916927 INFO (qtp65102727-8728) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=onlyinzk&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2589 [junit4] 2> 916928 INFO (qtp65102727-8732) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 916928 INFO (qtp65102727-8732) [n:127.0.0.1:56228_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> 916929 INFO (TEST-CollectionsAPIDistributedZkTest.deleteCollectionOnlyInZk-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending deleteCollectionOnlyInZk [junit4] 2> 916977 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testZeroNumShards [junit4] 2> 916981 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 916984 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=onlyinzk&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 916989 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 916991 INFO (qtp538759068-8760) [n:127.0.0.1:56231_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.onlyinzk.shard1.replica1, tag=null [junit4] 2> 916991 INFO (qtp912984427-8739) [n:127.0.0.1:56230_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.onlyinzk.shard2.replica1, tag=null [junit4] 2> 916992 INFO (qtp538759068-8760) [n:127.0.0.1:56231_solr ] o.a.s.c.SolrCore [onlyinzk_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@5d275830 [junit4] 2> 916992 INFO (qtp912984427-8739) [n:127.0.0.1:56230_solr ] o.a.s.c.SolrCore [onlyinzk_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@44b78856 [junit4] 2> 916994 INFO (qtp538759068-8760) [n:127.0.0.1:56231_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.onlyinzk.shard1.replica1, tag=1562859568 [junit4] 2> 916995 INFO (qtp912984427-8739) [n:127.0.0.1:56230_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.onlyinzk.shard2.replica1, tag=1152878678 [junit4] 2> 917001 INFO (qtp538759068-8760) [n:127.0.0.1:56231_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=onlyinzk_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=10 [junit4] 2> 917004 INFO (qtp912984427-8739) [n:127.0.0.1:56230_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=onlyinzk_shard2_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=13 [junit4] 2> 917727 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=onlyinzk&action=DELETE&wt=javabin&version=2} status=0 QTime=742 [junit4] 2> 917728 INFO (qtp65102727-8729) [n:127.0.0.1:56228_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> 917731 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection acollection [junit4] 2> 917732 ERROR (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_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:225) [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:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 917732 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_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> 917741 INFO (qtp65102727-8729) [n:127.0.0.1:56228_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=12 [junit4] 2> 917742 INFO (TEST-CollectionsAPIDistributedZkTest.testZeroNumShards-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testZeroNumShards [junit4] 2> 917776 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTooManyReplicas [junit4] 2> 917778 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 917781 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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> 917785 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection collection [junit4] 2> 917785 WARN (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_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> 917785 ERROR (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_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:225) [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:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 917785 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000016 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 917789 INFO (qtp65102727-8731) [n:127.0.0.1:56228_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=8 [junit4] 2> 917790 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTooManyReplicas [junit4] 2> 917833 INFO (TEST-CollectionsAPIDistributedZkTest.testMissingNumShards-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMissingNumShards [junit4] 2> 917835 INFO (TEST-CollectionsAPIDistributedZkTest.testMissingNumShards-seed#[EF81F54EA752694E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 917838 INFO (qtp65102727-8733) [n:127.0.0.1:56228_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> 917841 INFO (OverseerThreadFactory-3277-thread-5-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.CreateCollectionCmd Create collection acollection [junit [...truncated too long message...] 6229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: oversharded operation: create failed:org.apache.solr.common.SolrException: Cannot create collection oversharded. 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 3 and value of replicationFactor is 2. This requires 6 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:225) [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:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 1020386 INFO (OverseerCollectionConfigSetProcessor-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000072 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 1020390 INFO (qtp65102727-8730) [n:127.0.0.1:56228_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=2&collection.configName=conf&name=oversharded&action=CREATE&numShards=3&wt=javabin&version=2} status=400 QTime=8 [junit4] 2> 1020391 INFO (TEST-CollectionsAPIDistributedZkTest.testMaxNodesPerShard-seed#[EF81F54EA752694E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMaxNodesPerShard [junit4] 2> 1020400 INFO (jetty-closer-2221-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3af526ed{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1020401 INFO (jetty-closer-2221-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@39cb9455{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1020402 INFO (jetty-closer-2221-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@634de947{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1020403 INFO (jetty-closer-2221-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=128808366 [junit4] 2> 1020403 INFO (jetty-closer-2221-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=937201374 [junit4] 2> 1020404 INFO (jetty-closer-2221-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1020404 INFO (jetty-closer-2221-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1020404 INFO (jetty-closer-2221-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1111121922 [junit4] 2> 1020404 INFO (jetty-closer-2221-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1020405 INFO (jetty-closer-2221-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@23e2f39b{HTTP/1.1,[http/1.1]}{127.0.0.1:56230} [junit4] 2> 1020406 INFO (jetty-closer-2221-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=160949680 [junit4] 2> 1020406 INFO (jetty-closer-2221-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1020407 INFO (jetty-closer-2221-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1020407 INFO (jetty-closer-2221-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1020408 INFO (jetty-closer-2221-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1020410 INFO (jetty-closer-2221-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1020413 WARN (zkCallback-2240-thread-4-processing-n:127.0.0.1:56228_solr) [n:127.0.0.1:56228_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 1020415 INFO (jetty-closer-2221-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1dbd8d51{/solr,null,UNAVAILABLE} [junit4] 2> 1020415 INFO (jetty-closer-2221-thread-3) [ ] o.a.s.c.Overseer Overseer (id=97743116326076425-127.0.0.1:56229_solr-n_0000000000) closing [junit4] 2> 1020416 INFO (OverseerStateUpdate-97743116326076425-127.0.0.1:56229_solr-n_0000000000) [n:127.0.0.1:56229_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:56229_solr [junit4] 2> 1020416 INFO (zkCallback-2239-thread-7-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1) [junit4] 2> 1020421 WARN (zkCallback-2239-thread-7-processing-n:127.0.0.1:56229_solr) [n:127.0.0.1:56229_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 1020422 INFO (jetty-closer-2221-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4887d3fb{/solr,null,UNAVAILABLE} [junit4] 2> 1021914 WARN (zkCallback-2241-thread-3-processing-n:127.0.0.1:56231_solr) [n:127.0.0.1:56231_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 1021914 WARN (zkCallback-2277-thread-5-processing-n:127.0.0.1:56230_solr) [n:127.0.0.1:56230_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 1021915 INFO (jetty-closer-2221-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4783b6c6{/solr,null,UNAVAILABLE} [junit4] 2> 1021915 INFO (jetty-closer-2221-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@595e0ef5{/solr,null,UNAVAILABLE} [junit4] 2> 1021918 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56226 56226 [junit4] 2> 1021920 INFO (Thread-1426) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56226 56226 [junit4] 2> 1032123 WARN (Thread-1426) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 21 /solr/collections [junit4] 2> 5 /solr/overseer/queue [junit4] 2> [junit4] 2> 1032123 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF81F54EA752694E]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF81F54EA752694E-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {_version_=Lucene50(blocksize=128), id=PostingsFormat(name=Memory)}, docValues:{}, maxPointsInLeafNode=368, maxMBSortInHeap=5.582123142855667, sim=RandomSimilarity(queryNorm=false): {}, locale=ar-MA, timezone=America/Thule [junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 (64-bit)/cpus=3,threads=1,free=358730456,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [OverseerTaskQueueTest, TestDelegationWithHadoopAuth, TestFuzzyAnalyzedSuggestions, SubstringBytesRefFilterTest, TestSubQueryTransformer, TestTrie, FieldMutatingUpdateProcessorTest, TestJmxMonitoredMap, TestMacros, RAMDirectoryFactoryTest, SpellCheckCollatorTest, TestJavabinTupleStreamParser, SpellCheckComponentTest, BasicDistributedZk2Test, ParsingFieldUpdateProcessorsTest, ConfigureRecoveryStrategyTest, TestCodecSupport, TestCollectionAPIs, SolrXmlInZkTest, TestCryptoKeys, CdcrVersionReplicationTest, TestDocTermOrds, URLClassifyProcessorTest, TestRequestStatusCollectionAPI, TestDefaultStatsCache, RulesTest, TestAnalyzedSuggestions, OverseerRolesTest, SolrCloudReportersTest, CacheHeaderTest, TestSolrConfigHandlerCloud, TestRangeQuery, TestReloadDeadlock, LeaderInitiatedRecoveryOnShardRestartTest, DeleteNodeTest, TestQueryTypes, LeaderFailureAfterFreshStartTest, FullHLLTest, TestJsonRequest, TestJoin, TestFieldSortValues, TestGraphTermsQParserPlugin, CursorMarkTest, SortSpecParsingTest, TestExpandComponent, BasicFunctionalityTest, NotRequiredUniqueKeyTest, ChaosMonkeySafeLeaderTest, LeaderElectionIntegrationTest, TestCloudRecovery, TestPathTrie, BadComponentTest, SuggesterWFSTTest, CoreAdminHandlerTest, DistributedFacetPivotLargeTest, ExternalFileFieldSortTest, HdfsUnloadDistributedZkTest, TestDynamicFieldCollectionResource, TestRawResponseWriter, QueryParsingTest, TestAtomicUpdateErrorCases, TestFieldCacheSortRandom, TestRandomFaceting, MetricsHandlerTest, TestDistributedMissingSort, TestSystemIdResolver, TestSolr4Spatial2, TestSchemaNameResource, TestSolrQueryParserResource, TestInitQParser, TestCustomStream, TestValueSourceCache, TestSearchPerf, SimpleMLTQParserTest, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, TestXmlQParser, BasicAuthStandaloneTest, MergeStrategyTest, RegexBoostProcessorTest, CollectionsAPIDistributedZkTest] [junit4] Completed [186/702 (1!)] on J1 in 156.41s, 20 tests, 1 error <<< FAILURES! [...truncated 45001 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
