Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19433/ Java: 32bit/jdk1.8.0_121 -client -XX:+UseParallelGC
2 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testNoConfigSetExist Error Message: Error from server at https://127.0.0.1:45919/solr: Could not fully remove collection: addReplicaColl Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:45919/solr: Could not fully remove collection: addReplicaColl at __randomizedtesting.SeedInfo.seed([F5C14D821BAAF4F3:A9F3F65B08AC3FAA]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:627) 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:451) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:392) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1383) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1134) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1073) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:177) at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:442) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.clearCluster(CollectionsAPIDistributedZkTest.java:113) 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$9.evaluate(RandomizedRunner.java:941) 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) FAILED: org.apache.solr.handler.admin.StatsReloadRaceTest.testParallelReloadAndStats Error Message: Key SEARCHER.searcher.indexVersion not found in registry solr.core.collection1 Stack Trace: java.lang.AssertionError: Key SEARCHER.searcher.indexVersion not found in registry solr.core.collection1 at __randomizedtesting.SeedInfo.seed([F5C14D821BAAF4F3:3A5F28BB945B9CAC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.handler.admin.StatsReloadRaceTest.requestMetrics(StatsReloadRaceTest.java:132) at org.apache.solr.handler.admin.StatsReloadRaceTest.testParallelReloadAndStats(StatsReloadRaceTest.java:70) 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 11454 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/init-core-data-001 [junit4] 2> 322557 WARN (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 322558 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields [junit4] 2> 322560 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 322561 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001 [junit4] 2> 322561 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 322562 INFO (Thread-747) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 322562 INFO (Thread-747) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 322662 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:42945 [junit4] 2> 322672 INFO (jetty-launcher-536-thread-3) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 322672 INFO (jetty-launcher-536-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 322672 INFO (jetty-launcher-536-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 322673 INFO (jetty-launcher-536-thread-4) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 322674 INFO (jetty-launcher-536-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@156d41{/solr,null,AVAILABLE} [junit4] 2> 322674 INFO (jetty-launcher-536-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@f40d8f{/solr,null,AVAILABLE} [junit4] 2> 322674 INFO (jetty-launcher-536-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ded1c1{/solr,null,AVAILABLE} [junit4] 2> 322674 INFO (jetty-launcher-536-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1a8d1bf{/solr,null,AVAILABLE} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1e89ee6{SSL,[ssl, http/1.1]}{127.0.0.1:39002} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@691a5f{SSL,[ssl, http/1.1]}{127.0.0.1:42173} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@b295c8{SSL,[ssl, http/1.1]}{127.0.0.1:45919} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-1) [ ] o.e.j.s.Server Started @324092ms [junit4] 2> 322677 INFO (jetty-launcher-536-thread-2) [ ] o.e.j.s.Server Started @324092ms [junit4] 2> 322677 INFO (jetty-launcher-536-thread-4) [ ] o.e.j.s.Server Started @324092ms [junit4] 2> 322677 INFO (jetty-launcher-536-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1a54766{SSL,[ssl, http/1.1]}{127.0.0.1:40272} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39002} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-3) [ ] o.e.j.s.Server Started @324092ms [junit4] 2> 322677 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45919} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42173} [junit4] 2> 322677 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40272} [junit4] 2> 322678 ERROR (jetty-launcher-536-thread-4) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 322678 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 322679 ERROR (jetty-launcher-536-thread-3) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 322679 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 322678 ERROR (jetty-launcher-536-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 322678 ERROR (jetty-launcher-536-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 322679 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 322679 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 322679 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 322679 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 322679 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 322680 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-19T19:08:44.995Z [junit4] 2> 322680 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 322680 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 322680 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 322680 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-19T19:08:44.995Z [junit4] 2> 322680 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 322680 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 322680 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-19T19:08:44.995Z [junit4] 2> 322680 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-04-19T19:08:44.995Z [junit4] 2> 322682 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 322682 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 322682 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 322683 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 322691 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15b879de9ce0004, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 322695 INFO (jetty-launcher-536-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42945/solr [junit4] 2> 322695 INFO (jetty-launcher-536-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42945/solr [junit4] 2> 322696 INFO (jetty-launcher-536-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42945/solr [junit4] 2> 322696 INFO (jetty-launcher-536-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42945/solr [junit4] 2> 322698 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15b879de9ce0005, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 322718 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 322718 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 322718 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 322718 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 322719 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:45919_solr [junit4] 2> 322719 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40272_solr [junit4] 2> 322720 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39002_solr [junit4] 2> 322720 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42173_solr [junit4] 2> 322720 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.c.Overseer Overseer (id=97820929220804620-127.0.0.1:45919_solr-n_0000000000) starting [junit4] 2> 322721 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 322722 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 322721 INFO (zkCallback-556-thread-1-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 322722 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 322723 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 322723 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 322727 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 322727 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 322732 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45919_solr [junit4] 2> 322733 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 322733 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 322733 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 322734 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 322980 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 322985 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 322985 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 322987 INFO (jetty-launcher-536-thread-1) [n:127.0.0.1:42173_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1 [junit4] 2> 322997 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323005 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323005 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323010 INFO (jetty-launcher-536-thread-2) [n:127.0.0.1:45919_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2 [junit4] 2> 323179 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323186 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323186 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323187 INFO (jetty-launcher-536-thread-4) [n:127.0.0.1:39002_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4 [junit4] 2> 323283 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323289 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323289 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 323290 INFO (jetty-launcher-536-thread-3) [n:127.0.0.1:40272_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node3 [junit4] 2> 323331 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 323332 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42945/solr ready [junit4] 2> 323377 INFO (TEST-CollectionsAPIDistributedZkTest.testBadActionNames-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBadActionNames [junit4] 2> 323379 INFO (TEST-CollectionsAPIDistributedZkTest.testBadActionNames-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 323447 ERROR (qtp16480983-3160) [n:127.0.0.1:45919_solr ] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Unknown action: BADACTION [junit4] 2> at org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:210) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:178) [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:355) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:306) [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:462) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) [junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 323449 INFO (qtp16480983-3160) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=badactioncollection&action=BADACTION&numShards=2&wt=javabin&version=2} status=400 QTime=3 [junit4] 2> 323450 INFO (TEST-CollectionsAPIDistributedZkTest.testBadActionNames-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBadActionNames [junit4] 2> 323477 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTooManyReplicas [junit4] 2> 323478 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 323481 INFO (qtp16480983-3132) [n:127.0.0.1:45919_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> 323484 INFO (OverseerThreadFactory-1440-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.CreateCollectionCmd Create collection collection [junit4] 2> 323484 WARN (OverseerThreadFactory-1440-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_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> 323485 ERROR (OverseerThreadFactory-1440-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.OverseerCollectionMessageHandler Collection: collection operation: create failed:org.apache.solr.common.SolrException: Cannot create collection collection. Value of maxShardsPerNode is 1, and the number of nodes currently live or live and part of your createNodeSet is 4. This allows a maximum of 4 to be created. Value of numShards is 2 and value of replicationFactor is 10. This requires 20 shards to be created (higher than the allowed number) [junit4] 2> at org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:155) [junit4] 2> at org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:226) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java: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> 323489 INFO (qtp16480983-3132) [n:127.0.0.1:45919_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> 323490 INFO (TEST-CollectionsAPIDistributedZkTest.testTooManyReplicas-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTooManyReplicas [junit4] 2> 323520 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionReload-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionReload [junit4] 2> 323521 INFO (TEST-CollectionsAPIDistributedZkTest.testCollectionReload-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 323523 INFO (qtp16480983-3153) [n:127.0.0.1:45919_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&collection.configName=conf&name=reloaded_collection&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 323525 INFO (OverseerThreadFactory-1440-thread-2-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.CreateCollectionCmd Create collection reloaded_collection [junit4] 2> 323525 INFO (OverseerCollectionConfigSetProcessor-97820929220804620-127.0.0.1:45919_solr-n_0000000000) [n:127.0.0.1:45919_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> 323644 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2 [junit4] 2> 323645 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 323709 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2 [junit4] 2> 323709 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2 [junit4] 2> 323710 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 323710 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 323715 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2 [junit4] 2> 323716 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 323819 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 323819 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 323819 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 323819 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 324656 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 324665 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica2] Schema name=minimal [junit4] 2> 324667 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 324667 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard1_replica2' using configuration from collection reloaded_collection, trusted=true [junit4] 2> 324668 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard1.replica2' (registry 'solr.core.reloaded_collection.shard1.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 324668 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 324668 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2/data/] [junit4] 2> 324738 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 324738 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 324738 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 324749 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 324749 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 324752 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 324752 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 324756 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1851444[reloaded_collection_shard1_replica2] main] [junit4] 2> 324758 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 324758 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 324760 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 324763 INFO (searcherExecutor-1449-thread-1-processing-n:127.0.0.1:45919_solr x:reloaded_collection_shard1_replica2 s:shard1 c:reloaded_collection) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SolrCore [reloaded_collection_shard1_replica2] Registered new searcher Searcher@1851444[reloaded_collection_shard1_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 324763 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1565134869839740928 [junit4] 2> 324764 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica1] Schema name=minimal [junit4] 2> 324767 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica1] Schema name=minimal [junit4] 2> 324768 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica2] Schema name=minimal [junit4] 2> 324772 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 324772 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard1_replica1' using configuration from collection reloaded_collection, trusted=true [junit4] 2> 324772 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard1.replica1' (registry 'solr.core.reloaded_collection.shard1.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 324772 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 324773 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 324773 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard2_replica2' using configuration from collection reloaded_collection, trusted=true [junit4] 2> 324773 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 324773 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1/data/] [junit4] 2> 324773 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'reloaded_collection_shard2_replica1' using configuration from collection reloaded_collection, trusted=true [junit4] 2> 324773 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms [junit4] 2> 324773 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard2.replica2' (registry 'solr.core.reloaded_collection.shard2.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 324773 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 324774 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node3/reloaded_collection_shard2_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node3/reloaded_collection_shard2_replica2/data/] [junit4] 2> 324774 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard2.replica1' (registry 'solr.core.reloaded_collection.shard2.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 324774 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 324774 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1/data/] [junit4] 2> 324851 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 324851 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 324853 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 324853 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 324855 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.s.SolrIndexSearcher Opening [Searcher@a36d8b[reloaded_collection_shard2_replica2] main] [junit4] 2> 324856 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 324856 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 324857 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 324860 INFO (searcherExecutor-1455-thread-1-processing-n:127.0.0.1:40272_solr x:reloaded_collection_shard2_replica2 s:shard2 c:reloaded_collection) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SolrCore [reloaded_collection_shard2_replica2] Registered new searcher Searcher@a36d8b[reloaded_collection_shard2_replica2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 324860 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1565134869941452800 [junit4] 2> 324864 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 324864 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 324866 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 324867 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 324869 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@498ab5[reloaded_collection_shard1_replica1] main] [junit4] 2> 324871 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 324871 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms [junit4] 2> 324871 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 324871 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 324871 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 324872 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 324874 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 324874 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 324875 INFO (searcherExecutor-1454-thread-1-processing-n:127.0.0.1:42173_solr x:reloaded_collection_shard1_replica1 s:shard1 c:reloaded_collection) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.c.SolrCore [reloaded_collection_shard1_replica1] Registered new searcher Searcher@498ab5[reloaded_collection_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 324875 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1565134869957181440 [junit4] 2> 324878 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f7e37[reloaded_collection_shard2_replica1] main] [junit4] 2> 324879 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 324879 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 324881 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 324882 INFO (searcherExecutor-1456-thread-1-processing-n:127.0.0.1:39002_solr x:reloaded_collection_shard2_replica1 s:shard2 c:reloaded_collection) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.c.SolrCore [reloaded_collection_shard2_replica1] Registered new searcher Searcher@4f7e37[reloaded_collection_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 324883 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1565134869965570048 [junit4] 2> 324973 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 324973 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 324973 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 324973 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325274 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 325274 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 325274 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:45919/solr/reloaded_collection_shard1_replica2/ [junit4] 2> 325275 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard1_replica2 url=https://127.0.0.1:45919/solr START replicas=[https://127.0.0.1:42173/solr/reloaded_collection_shard1_replica1/] nUpdates=100 [junit4] 2> 325275 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard1_replica2 url=https://127.0.0.1:45919/solr DONE. We have no versions. sync failed. [junit4] 2> 325285 INFO (qtp14902894-3156) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 r:core_node2 x:reloaded_collection_shard1_replica1] o.a.s.c.S.Request [reloaded_collection_shard1_replica1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 325286 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 325286 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 325286 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 325290 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:45919/solr/reloaded_collection_shard1_replica2/ shard1 [junit4] 2> 325371 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 325371 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 325371 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:40272/solr/reloaded_collection_shard2_replica2/ [junit4] 2> 325372 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard2_replica2 url=https://127.0.0.1:40272/solr START replicas=[https://127.0.0.1:39002/solr/reloaded_collection_shard2_replica1/] nUpdates=100 [junit4] 2> 325372 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.u.PeerSync PeerSync: core=reloaded_collection_shard2_replica2 url=https://127.0.0.1:40272/solr DONE. We have no versions. sync failed. [junit4] 2> 325380 INFO (qtp29752388-3141) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 r:core_node4 x:reloaded_collection_shard2_replica1] o.a.s.c.S.Request [reloaded_collection_shard2_replica1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 325381 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 325381 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 325381 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 325385 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:40272/solr/reloaded_collection_shard2_replica2/ shard2 [junit4] 2> 325488 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325488 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325488 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325488 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325491 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 325493 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2} status=0 QTime=1848 [junit4] 2> 325536 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 325539 INFO (qtp9501242-3158) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica2&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2} status=0 QTime=1830 [junit4] 2> 325640 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325640 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325640 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325640 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 325881 INFO (qtp14902894-3164) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 x:reloaded_collection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard1_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard1&wt=javabin&version=2} status=0 QTime=2172 [junit4] 2> 325903 INFO (qtp29752388-3163) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 x:reloaded_collection_shard2_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=reloaded_collection_shard2_replica1&action=CREATE&numShards=2&collection=reloaded_collection&shard=shard2&wt=javabin&version=2} status=0 QTime=2188 [junit4] 2> 325906 INFO (qtp16480983-3153) [n:127.0.0.1:45919_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> 326004 INFO (zkCallback-555-thread-1-processing-n:127.0.0.1:40272_solr) [n:127.0.0.1:40272_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 326005 INFO (zkCallback-557-thread-1-processing-n:127.0.0.1:39002_solr) [n:127.0.0.1:39002_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 326005 INFO (zkCallback-558-thread-1-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 326005 INFO (zkCallback-556-thread-2-processing-n:127.0.0.1:42173_solr) [n:127.0.0.1:42173_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/reloaded_collection/state.json] for collection [reloaded_collection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 326907 INFO (qtp16480983-3153) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=2&collection.configName=conf&name=reloaded_collection&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=3383 [junit4] 2> 326916 INFO (qtp16480983-3137) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326923 INFO (qtp14902894-3156) [n:127.0.0.1:42173_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326932 INFO (qtp9501242-3155) [n:127.0.0.1:40272_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326940 INFO (qtp29752388-3141) [n:127.0.0.1:39002_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326943 INFO (qtp16480983-3157) [n:127.0.0.1:45919_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :reload with params async=46276180-1bde-4482-9d55-1b09f69c0a5e&name=reloaded_collection&action=RELOAD&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 326944 INFO (qtp16480983-3157) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=46276180-1bde-4482-9d55-1b09f69c0a5e&name=reloaded_collection&action=RELOAD&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 326945 INFO (OverseerThreadFactory-1440-thread-3-processing-n:127.0.0.1:45919_solr) [n:127.0.0.1:45919_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=RELOAD [junit4] 2> 326946 INFO (OverseerCollectionConfigSetProcessor-97820929220804620-127.0.0.1:45919_solr-n_0000000000) [n:127.0.0.1:45919_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> 326949 INFO (qtp16480983-3160) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard1_replica2&async=46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326949 INFO (qtp14902894-3133) [n:127.0.0.1:42173_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard1_replica1&async=46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326950 ERROR (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2/conf/solrcore.properties:java.nio.file.NoSuchFileException: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2/conf/solrcore.properties [junit4] 2> 326951 ERROR (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1/conf/solrcore.properties:java.nio.file.NoSuchFileException: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1/conf/solrcore.properties [junit4] 2> 326951 INFO (qtp9501242-3134) [n:127.0.0.1:40272_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard2_replica2&async=46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 326952 INFO (qtp29752388-3135) [n:127.0.0.1:39002_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=reloaded_collection_shard2_replica1&async=46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632&qt=/admin/cores&action=RELOAD&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 326952 ERROR (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node3/reloaded_collection_shard2_replica2/conf/solrcore.properties:java.nio.file.NoSuchFileException: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node3/reloaded_collection_shard2_replica2/conf/solrcore.properties [junit4] 2> 326952 ERROR (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1/conf/solrcore.properties:java.nio.file.NoSuchFileException: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1/conf/solrcore.properties [junit4] 2> 326954 INFO (qtp9501242-3155) [n:127.0.0.1:40272_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 [junit4] 2> 326956 INFO (qtp9501242-3155) [n:127.0.0.1:40272_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 326957 INFO (qtp16480983-3160) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326967 INFO (qtp14902894-3133) [n:127.0.0.1:42173_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 326984 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 326987 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 326987 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 326989 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 326993 INFO (qtp9501242-3134) [n:127.0.0.1:40272_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327004 INFO (qtp29752388-3135) [n:127.0.0.1:39002_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327004 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica1] Schema name=minimal [junit4] 2> 327006 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica1] Schema name=minimal [junit4] 2> 327007 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr ] o.a.s.s.IndexSchema [reloaded_collection_shard1_replica2] Schema name=minimal [junit4] 2> 327007 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr ] o.a.s.s.IndexSchema [reloaded_collection_shard2_replica2] Schema name=minimal [junit4] 2> 327009 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 327009 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard2_replica1' using configuration from collection reloaded_collection [junit4] 2> 327011 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 327011 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard1_replica1' using configuration from collection reloaded_collection [junit4] 2> 327014 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 327014 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 327014 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard2_replica2' using configuration from collection reloaded_collection [junit4] 2> 327014 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr ] o.a.s.c.CoreContainer Reloading SolrCore 'reloaded_collection_shard1_replica2' using configuration from collection reloaded_collection [junit4] 2> 327027 INFO (qtp16480983-3140) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327041 INFO (qtp14902894-3146) [n:127.0.0.1:42173_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327059 INFO (qtp9501242-3155) [n:127.0.0.1:40272_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327075 INFO (qtp29752388-3135) [n:127.0.0.1:39002_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327087 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 r:core_node4 x:reloaded_collection_shard2_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard2.replica1' (registry 'solr.core.reloaded_collection.shard2.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 327087 INFO (parallelCoreAdminExecutor-1445-thread-1-processing-n:127.0.0.1:39002_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459839632 RELOAD) [n:127.0.0.1:39002_solr c:reloaded_collection s:shard2 r:core_node4 x:reloaded_collection_shard2_replica1] o.a.s.c.SolrCore [[reloaded_collection_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node4/reloaded_collection_shard2_replica1/data/] [junit4] 2> 327093 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 r:core_node2 x:reloaded_collection_shard1_replica1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard1.replica1' (registry 'solr.core.reloaded_collection.shard1.replica1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 327093 INFO (parallelCoreAdminExecutor-1441-thread-1-processing-n:127.0.0.1:42173_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459757454 RELOAD) [n:127.0.0.1:42173_solr c:reloaded_collection s:shard1 r:core_node2 x:reloaded_collection_shard1_replica1] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node1/reloaded_collection_shard1_replica1/data/] [junit4] 2> 327096 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 r:core_node1 x:reloaded_collection_shard1_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard1.replica2' (registry 'solr.core.reloaded_collection.shard1.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 327096 INFO (parallelCoreAdminExecutor-1442-thread-1-processing-n:127.0.0.1:45919_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459641012 RELOAD) [n:127.0.0.1:45919_solr c:reloaded_collection s:shard1 r:core_node1 x:reloaded_collection_shard1_replica2] o.a.s.c.SolrCore [[reloaded_collection_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_F5C14D821BAAF4F3-001/tempDir-001/node2/reloaded_collection_shard1_replica2/data/] [junit4] 2> 327101 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-4482-9d55-1b09f69c0a5e851666459804717 RELOAD) [n:127.0.0.1:40272_solr c:reloaded_collection s:shard2 r:core_node3 x:reloaded_collection_shard2_replica2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.reloaded_collection.shard2.replica2' (registry 'solr.core.reloaded_collection.shard2.replica2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c75a4a [junit4] 2> 327101 INFO (qtp16480983-3160) [n:127.0.0.1:45919_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=false&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 327101 INFO (parallelCoreAdminExecutor-1447-thread-1-processing-n:127.0.0.1:40272_solr 46276180-1bde-448 [...truncated too long message...] 2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1547064 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547064 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1547065 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1547065 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1547065 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547065 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1547065 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547065 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1547065 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547066 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547067 INFO (parallelCoreAdminExecutor-2837-thread-2-processing-2 RELOAD) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=937663860, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1547067 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547067 INFO (parallelCoreAdminExecutor-2837-thread-2-processing-2 RELOAD) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1547068 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547069 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547069 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547070 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547070 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547071 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547071 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547072 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.h.a.CoreAdminOperation Checking request status for : 2 [junit4] 2> 1547073 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@eb0472[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C32)))} [junit4] 2> 1547074 INFO (parallelCoreAdminExecutor-2837-thread-2-processing-2 RELOAD) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@19d844e[collection1] main] [junit4] 2> 1547074 INFO (parallelCoreAdminExecutor-2837-thread-2-processing-2 RELOAD) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@660d16 [junit4] 2> 1547074 INFO (parallelCoreAdminExecutor-2837-thread-2-processing-2 RELOAD) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=6688022 [junit4] 2> 1547080 INFO (searcherExecutor-2848-thread-1-processing-x:collection1 2 RELOAD) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@19d844e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C32)))} [junit4] 2> 1557079 INFO (TEST-StatsReloadRaceTest.testParallelReloadAndStats-seed#[F5C14D821BAAF4F3]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testParallelReloadAndStats [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=StatsReloadRaceTest -Dtests.method=testParallelReloadAndStats -Dtests.seed=F5C14D821BAAF4F3 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-SA -Dtests.timezone=Etc/GMT+4 -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 10.9s J0 | StatsReloadRaceTest.testParallelReloadAndStats <<< [junit4] > Throwable #1: java.lang.AssertionError: Key SEARCHER.searcher.indexVersion not found in registry solr.core.collection1 [junit4] > at __randomizedtesting.SeedInfo.seed([F5C14D821BAAF4F3:3A5F28BB945B9CAC]:0) [junit4] > at org.apache.solr.handler.admin.StatsReloadRaceTest.requestMetrics(StatsReloadRaceTest.java:132) [junit4] > at org.apache.solr.handler.admin.StatsReloadRaceTest.testParallelReloadAndStats(StatsReloadRaceTest.java:70) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1557081 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1557081 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=32441775 [junit4] 2> 1557081 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1557083 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1557085 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1557086 INFO (SUITE-StatsReloadRaceTest-seed#[F5C14D821BAAF4F3]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1557086 INFO (coreCloseExecutor-2852-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@a3542d [junit4] 2> 1557087 INFO (coreCloseExecutor-2852-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=10703917 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.StatsReloadRaceTest_F5C14D821BAAF4F3-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name_s=Lucene50(blocksize=128), range_facet_l_dv=Lucene50(blocksize=128), multiDefault=PostingsFormat(name=Memory), intDefault=Lucene50(blocksize=128), id=Lucene50(blocksize=128), range_facet_i_dv=PostingsFormat(name=Memory), range_facet_l=PostingsFormat(name=Memory), timestamp=PostingsFormat(name=Memory)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), _version_=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Lucene70), intDvoDefault=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=2016, maxMBSortInHeap=5.140236345506614, sim=RandomSimilarity(queryNorm=true): {}, locale=ar-SA, timezone=Etc/GMT+4 [junit4] 2> NOTE: Linux 4.4.0-72-generic i386/Oracle Corporation 1.8.0_121 (32-bit)/cpus=12,threads=1,free=201563008,total=317718528 [junit4] 2> NOTE: All tests run in this JVM: [TestPseudoReturnFields, TestReplicationHandler, TestRawResponseWriter, TestSchemaManager, TestFoldingMultitermQuery, TestGraphMLResponseWriter, TestFieldCacheSort, LeaderElectionContextKeyTest, BasicDistributedZkTest, FileBasedSpellCheckerTest, TestSolrConfigHandlerCloud, TestCustomStream, BadCopyFieldTest, RankQueryTest, TestCustomDocTransformer, TestUseDocValuesAsStored2, TestUniqueKeyFieldResource, CurrencyFieldOpenExchangeTest, PreAnalyzedUpdateProcessorTest, PolyFieldTest, CopyFieldTest, BlobRepositoryCloudTest, TestCollapseQParserPlugin, TestOmitPositions, RollingRestartTest, TestCopyFieldCollectionResource, TestRandomDVFaceting, TestSolr4Spatial2, TestHdfsBackupRestoreCore, TestValueSourceCache, MissingSegmentRecoveryTest, BasicAuthIntegrationTest, ResponseLogComponentTest, TestFastWriter, TestFunctionQuery, TestStressLucene, StatsReloadRaceTest] [junit4] Completed [433/702 (2!)] on J0 in 11.69s, 1 test, 1 failure <<< FAILURES! [...truncated 40255 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
