Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/296/ Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.client.solrj.impl.CloudSolrClientTest.testRetryUpdatesWhenClusterStateIsStale Error Message: Error from server at http://127.0.0.1:37591/solr/stale_state_test_col_shard1_replica_n1: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 404 </title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem accessing /solr/stale_state_test_col_shard1_replica_n1/update. Reason: <pre> Can not find: /solr/stale_state_test_col_shard1_replica_n1/update</pre></p> <hr /><a href="http://eclipse.org/jetty";>Powered by Jetty:// 9.3.20.v20170531</a><hr/> </body> </html> Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37591/solr/stale_state_test_col_shard1_replica_n1: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 404 </title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem accessing /solr/stale_state_test_col_shard1_replica_n1/update. Reason: <pre> Can not find: /solr/stale_state_test_col_shard1_replica_n1/update</pre></p> <hr /><a href="http://eclipse.org/jetty";>Powered by Jetty:// 9.3.20.v20170531</a><hr/> </body> </html> at __randomizedtesting.SeedInfo.seed([80E3DB53DBDE942A:34D243BB3837E206]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:559) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1016) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233) at org.apache.solr.client.solrj.impl.CloudSolrClientTest.testRetryUpdatesWhenClusterStateIsStale(CloudSolrClientTest.java:844) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.junit.rules.ExpectedException$ExpectedExceptionStatement.evaluate(ExpectedException.java:110) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 14752 lines...] [junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientTest [junit4] 2> 150530 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/init-core-data-001 [junit4] 2> 150530 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 150530 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 150530 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001 [junit4] 2> 150530 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 150530 INFO (Thread-402) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 150530 INFO (Thread-402) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 150536 ERROR (Thread-402) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 150630 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:45976 [junit4] 2> 150639 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 150639 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 150639 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 150641 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e5fe95d{/solr,null,AVAILABLE} [junit4] 2> 150641 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3375cfa2{/solr,null,AVAILABLE} [junit4] 2> 150642 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@bc67b86{HTTP/1.1,[http/1.1]}{127.0.0.1:37400} [junit4] 2> 150642 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.Server Started @152895ms [junit4] 2> 150642 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37400} [junit4] 2> 150642 ERROR (jetty-launcher-508-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 150643 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@783d2e4b{HTTP/1.1,[http/1.1]}{127.0.0.1:37591} [junit4] 2> 150645 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.Server Started @152898ms [junit4] 2> 150645 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 150646 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37591} [junit4] 2> 150646 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 150646 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 150646 ERROR (jetty-launcher-508-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 150646 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-11T10:45:16.052Z [junit4] 2> 150646 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 150646 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 150646 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 150646 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-11T10:45:16.052Z [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@b628849{/solr,null,AVAILABLE} [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6612e584{HTTP/1.1,[http/1.1]}{127.0.0.1:55460} [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.Server Started @152900ms [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=55460} [junit4] 2> 150647 ERROR (jetty-launcher-508-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.2.0 [junit4] 2> 150647 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 150648 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 150648 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-11T10:45:16.054Z [junit4] 2> 150651 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 150652 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 150653 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 150659 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45976/solr [junit4] 2> 150659 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45976/solr [junit4] 2> 150662 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45976/solr [junit4] 2> 150695 WARN (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null [junit4] 2> 150695 WARN (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null [junit4] 2> 150697 WARN (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.c.ZkController The _default configset could not be uploaded. Please provide 'solr.default.confdir' parameter that points to a configset intended to be the default. Current 'solr.default.confdir' value: null [junit4] 2> 150704 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 150704 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 150704 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 150705 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:55460_solr [junit4] 2> 150706 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37400_solr [junit4] 2> 150706 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37591_solr [junit4] 2> 150706 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.Overseer Overseer (id=98985385390309385-127.0.0.1:55460_solr-n_0000000000) starting [junit4] 2> 150717 INFO (zkCallback-525-thread-1-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 150727 INFO (zkCallback-523-thread-1-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 150758 INFO (zkCallback-524-thread-1-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 150773 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:55460_solr [junit4] 2> 150777 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37591.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150782 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37591.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150782 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37591.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150783 INFO (jetty-launcher-508-thread-3) [n:127.0.0.1:37591_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node3/. [junit4] 2> 150784 INFO (zkCallback-523-thread-1-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 150793 INFO (zkCallback-524-thread-1-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 150797 INFO (zkCallback-525-thread-1-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 150851 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55460.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150851 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37400.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150856 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55460.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150856 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37400.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150856 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55460.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150856 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37400.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 150857 INFO (jetty-launcher-508-thread-2) [n:127.0.0.1:55460_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node2/. [junit4] 2> 150857 INFO (jetty-launcher-508-thread-1) [n:127.0.0.1:37400_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node1/. [junit4] 2> 150915 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 150916 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45976/solr ready [junit4] 2> 150923 INFO (qtp205035341-2221) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 150927 INFO (OverseerThreadFactory-918-thread-1-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.CreateCollectionCmd Create collection collection1 [junit4] 2> 151045 INFO (OverseerStateUpdate-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"collection1_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:55460/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 151052 INFO (OverseerStateUpdate-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"collection1", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"collection1_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:37591/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 151258 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 151260 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 151264 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 151265 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 151377 INFO (zkCallback-523-thread-1-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 151377 INFO (zkCallback-525-thread-1-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 151377 INFO (zkCallback-523-thread-2-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 151378 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152287 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 152291 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 152298 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=test [junit4] 2> 152303 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test [junit4] 2> 152358 WARN (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2) [junit4] 2> 152359 WARN (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3) [junit4] 2> 152359 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 152360 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using configuration from collection collection1, trusted=true [junit4] 2> 152362 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37591.solr.core.collection1.shard2.replica_n2' (registry 'solr.core.collection1.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 152363 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 152365 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node3/collection1_shard2_replica_n2], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node3/./collection1_shard2_replica_n2/data/] [junit4] 2> 152407 WARN (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2) [junit4] 2> 152407 WARN (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3) [junit4] 2> 152408 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 152408 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true [junit4] 2> 152409 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55460.solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 152410 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 152410 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node2/collection1_shard1_replica_n1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node2/./collection1_shard1_replica_n1/data/] [junit4] 2> 152477 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 152477 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 152478 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 152478 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 152478 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 152478 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 152479 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 152479 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 152480 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@540dd37a[collection1_shard2_replica_n2] main] [junit4] 2> 152480 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@195f00d4[collection1_shard1_replica_n1] main] [junit4] 2> 152481 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 152482 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 152482 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 152482 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 152483 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 152483 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1583766168287576064 [junit4] 2> 152483 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 152483 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1583766168287576064 [junit4] 2> 152484 INFO (searcherExecutor-924-thread-1-processing-n:127.0.0.1:37591_solr x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@540dd37a[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 152485 INFO (searcherExecutor-925-thread-1-processing-n:127.0.0.1:55460_solr x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@195f00d4[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 152490 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 152490 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 152490 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37591/solr/collection1_shard2_replica_n2/ [junit4] 2> 152490 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 152490 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:37591/solr/collection1_shard2_replica_n2/ has no replicas [junit4] 2> 152491 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/ [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/ has no replicas [junit4] 2> 152491 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 152497 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/ shard1 [junit4] 2> 152499 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:37591/solr/collection1_shard2_replica_n2/ shard2 [junit4] 2> 152604 INFO (zkCallback-523-thread-2-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152604 INFO (zkCallback-523-thread-1-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152606 INFO (zkCallback-525-thread-3-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152606 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152649 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 152653 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 152655 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1390 [junit4] 2> 152656 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1398 [junit4] 2> 152662 INFO (qtp205035341-2221) [n:127.0.0.1:37400_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> 152757 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152757 INFO (zkCallback-525-thread-3-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152760 INFO (zkCallback-523-thread-2-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152760 INFO (zkCallback-523-thread-1-processing-n:127.0.0.1:37591_solr) [n:127.0.0.1:37591_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 152930 INFO (OverseerCollectionConfigSetProcessor-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_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> 153665 INFO (qtp205035341-2221) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2741 [junit4] 2> 153665 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: collection1 failOnTimeout:true timeout (sec):30 [junit4] 2> 153666 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1 [junit4] 2> 153675 INFO (qtp384067903-2226) [n:127.0.0.1:37591_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 153676 INFO (qtp384067903-2226) [n:127.0.0.1:37591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 153693 INFO (TEST-CloudSolrClientTest.testVersionsAreReturned-seed#[80E3DB53DBDE942A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testVersionsAreReturned [junit4] 2> 153706 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:* (-1583766169566838784)} 0 2 [junit4] 2> 153709 INFO (qtp384067903-2228) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169573130240,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153709 INFO (qtp384067903-2228) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 153710 INFO (qtp384067903-2228) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153710 INFO (qtp384067903-2228) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 0 [junit4] 2> 153710 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169574178816,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153710 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 153711 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153711 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 0 [junit4] 2> 153722 INFO (qtp171693858-2241) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:* (-1583766169559498752),commit=} 0 26 [junit4] 2> 153726 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&versions=true&wt=javabin&version=2}{add=[1 (1583766169588858880)]} 0 1 [junit4] 2> 153726 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={_stateVer_=collection1:4&versions=true&wt=javabin&version=2}{add=[2 (1583766169589907456)]} 0 0 [junit4] 2> 153728 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169593053184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153728 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169593053184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153729 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3a630c07 commitCommandVersion:1583766169593053184 [junit4] 2> 153729 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@26d57df1 commitCommandVersion:1583766169593053184 [junit4] 2> 153737 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@36b5017[collection1_shard2_replica_n2] main] [junit4] 2> 153737 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@74ec0644[collection1_shard1_replica_n1] main] [junit4] 2> 153737 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153737 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153738 INFO (searcherExecutor-924-thread-1-processing-n:127.0.0.1:37591_solr x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@36b5017[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)))} [junit4] 2> 153738 INFO (qtp384067903-2225) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 10 [junit4] 2> 153738 INFO (searcherExecutor-925-thread-1-processing-n:127.0.0.1:55460_solr x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@74ec0644[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)))} [junit4] 2> 153738 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 10 [junit4] 2> 153743 INFO (qtp171693858-2216) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&versions=true&commit=true&wt=javabin&version=2}{commit=} 0 16 [junit4] 2> 153758 INFO (qtp171693858-2240) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510397119150&isShard=true&wt=javabin} hits=1 status=0 QTime=1 [junit4] 2> 153760 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:37591/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510397119150&isShard=true&wt=javabin} hits=1 status=0 QTime=0 [junit4] 2> 153768 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510397119150&ids=2&isShard=true&shard.url=http://127.0.0.1:37591/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 153769 INFO (qtp171693858-2240) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510397119150&ids=1&isShard=true&shard.url=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 153770 INFO (qtp384067903-2218) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4&wt=javabin&version=2} hits=2 status=0 QTime=26 [junit4] 2> 153771 INFO (qtp171693858-2240) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&versions=true&wt=javabin&version=2}{delete=[1 (-1583766169638141952)]} 0 0 [junit4] 2> 153782 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169649676288,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153783 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@26d57df1 commitCommandVersion:1583766169649676288 [junit4] 2> 153783 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8c1709[collection1_shard1_replica_n1] main] [junit4] 2> 153784 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153784 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169651773440,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153784 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 153784 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153785 INFO (searcherExecutor-925-thread-1-processing-n:127.0.0.1:55460_solr x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@8c1709[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 153785 INFO (qtp384067903-2224) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 1 [junit4] 2> 153785 INFO (qtp171693858-2238) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 3 [junit4] 2> 153786 INFO (qtp171693858-2240) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&versions=true&commit=true&wt=javabin&version=2}{commit=} 0 14 [junit4] 2> 153786 INFO (TEST-CloudSolrClientTest.testVersionsAreReturned-seed#[80E3DB53DBDE942A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testVersionsAreReturned [junit4] 2> 153805 INFO (TEST-CloudSolrClientTest.testHandlingOfStaleAlias-seed#[80E3DB53DBDE942A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testHandlingOfStaleAlias [junit4] 2> 153808 INFO (qtp384067903-2223) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@447874a5[collection1_shard2_replica_n2] realtime] [junit4] 2> 153809 INFO (qtp384067903-2223) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:* (-1583766169675890688)} 0 1 [junit4] 2> 153810 INFO (qtp171693858-2216) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169679036416,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153810 INFO (qtp171693858-2216) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 153810 INFO (qtp171693858-2216) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153810 INFO (qtp171693858-2216) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 0 [junit4] 2> 153813 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1583766169682182144,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 153813 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3a630c07 commitCommandVersion:1583766169682182144 [junit4] 2> 153814 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e22aa34[collection1_shard2_replica_n2] main] [junit4] 2> 153814 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 153815 INFO (searcherExecutor-924-thread-1-processing-n:127.0.0.1:37591_solr x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@3e22aa34[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 153815 INFO (qtp384067903-2227) [n:127.0.0.1:37591_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:55460/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 1 [junit4] 2> 153816 INFO (qtp171693858-2236) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:* (-1583766169674842112),commit=} 0 10 [junit4] 2> 153817 INFO (qtp205035341-2231) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 153819 INFO (qtp205035341-2231) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 153820 INFO (qtp205035341-2229) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 153821 INFO (qtp205035341-2229) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 153822 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 153833 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=11 [junit4] 2> 153834 INFO (qtp205035341-2232) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=nemesis&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 153839 INFO (OverseerThreadFactory-918-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.CreateCollectionCmd Create collection nemesis [junit4] 2> 154108 INFO (OverseerStateUpdate-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"nemesis", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"nemesis_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:55460/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 154112 INFO (OverseerStateUpdate-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"nemesis", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"nemesis_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:37400/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 154313 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=nemesis_shard1_replica_n1&action=CREATE&numShards=2&collection=nemesis&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 154314 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=nemesis_shard2_replica_n2&action=CREATE&numShards=2&collection=nemesis&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 154314 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 154424 INFO (zkCallback-525-thread-3-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 154425 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 154425 INFO (zkCallback-524-thread-1-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 154425 INFO (zkCallback-524-thread-2-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155330 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 155338 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.IndexSchema [nemesis_shard1_replica_n1] Schema name=test [junit4] 2> 155362 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 155369 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.IndexSchema [nemesis_shard2_replica_n2] Schema name=test [junit4] 2> 155420 WARN (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2) [junit4] 2> 155420 WARN (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3) [junit4] 2> 155420 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 155420 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'nemesis_shard2_replica_n2' using configuration from collection nemesis, trusted=true [junit4] 2> 155420 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_37400.solr.core.nemesis.shard2.replica_n2' (registry 'solr.core.nemesis.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 155420 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 155421 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SolrCore [[nemesis_shard2_replica_n2] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node1/nemesis_shard2_replica_n2], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node1/./nemesis_shard2_replica_n2/data/] [junit4] 2> 155432 WARN (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for multiple copyFields (2) [junit4] 2> 155432 WARN (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (3) [junit4] 2> 155432 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 155432 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'nemesis_shard1_replica_n1' using configuration from collection nemesis, trusted=true [junit4] 2> 155432 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55460.solr.core.nemesis.shard1.replica_n1' (registry 'solr.core.nemesis.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@758a4494 [junit4] 2> 155433 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 155433 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SolrCore [[nemesis_shard1_replica_n1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node2/nemesis_shard1_replica_n1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001/tempDir-001/node2/./nemesis_shard1_replica_n1/data/] [junit4] 2> 155468 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 155468 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 155469 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 155469 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 155470 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@488383f7[nemesis_shard2_replica_n2] main] [junit4] 2> 155471 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 155472 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 155472 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 155472 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1583766171421769728 [junit4] 2> 155472 INFO (searcherExecutor-934-thread-1-processing-n:127.0.0.1:37400_solr x:nemesis_shard2_replica_n2 s:shard2 c:nemesis r:core_node4) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SolrCore [nemesis_shard2_replica_n2] Registered new searcher Searcher@488383f7[nemesis_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37400/solr/nemesis_shard2_replica_n2/ [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:37400/solr/nemesis_shard2_replica_n2/ has no replicas [junit4] 2> 155479 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 155482 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:37400/solr/nemesis_shard2_replica_n2/ shard2 [junit4] 2> 155483 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 155483 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 155484 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 155484 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 155485 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@487bd158[nemesis_shard1_replica_n1] main] [junit4] 2> 155487 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 155488 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 155489 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 155489 INFO (searcherExecutor-935-thread-1-processing-n:127.0.0.1:55460_solr x:nemesis_shard1_replica_n1 s:shard1 c:nemesis r:core_node3) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SolrCore [nemesis_shard1_replica_n1] Registered new searcher Searcher@487bd158[nemesis_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 155489 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1583766171439595520 [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:55460/solr/nemesis_shard1_replica_n1/ [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:55460/solr/nemesis_shard1_replica_n1/ has no replicas [junit4] 2> 155495 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 155500 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:55460/solr/nemesis_shard1_replica_n1/ shard1 [junit4] 2> 155603 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155603 INFO (zkCallback-525-thread-3-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155604 INFO (zkCallback-524-thread-2-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155604 INFO (zkCallback-524-thread-1-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155633 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 155636 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr c:nemesis s:shard2 r:core_node4 x:nemesis_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=nemesis_shard2_replica_n2&action=CREATE&numShards=2&collection=nemesis&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1322 [junit4] 2> 155652 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 155655 INFO (qtp171693858-2235) [n:127.0.0.1:55460_solr c:nemesis s:shard1 r:core_node3 x:nemesis_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=nemesis_shard1_replica_n1&action=CREATE&numShards=2&collection=nemesis&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1341 [junit4] 2> 155658 INFO (qtp205035341-2232) [n:127.0.0.1:37400_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> 155756 INFO (zkCallback-524-thread-1-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155756 INFO (zkCallback-525-thread-2-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155756 INFO (zkCallback-524-thread-2-processing-n:127.0.0.1:37400_solr) [n:127.0.0.1:37400_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155756 INFO (zkCallback-525-thread-3-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/nemesis/state.json] for collection [nemesis] has occurred - updating... (live nodes size: [3]) [junit4] 2> 155842 INFO (OverseerCollectionConfigSetProcessor-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_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> 156660 INFO (qtp205035341-2232) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=nemesis&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2825 [junit4] 2> 156660 INFO (qtp205035341-2221) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156663 INFO (qtp205035341-2221) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156664 INFO (qtp205035341-2222) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156666 INFO (qtp205035341-2222) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156667 INFO (qtp205035341-2231) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156669 INFO (qtp205035341-2231) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156669 INFO (qtp205035341-2229) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params collections=nemesis&name=misconfigured-alias&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156779 INFO (qtp205035341-2229) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collections=nemesis&name=misconfigured-alias&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=109 [junit4] 2> 156780 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156783 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156784 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156786 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156787 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156789 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 156790 INFO (qtp205035341-2233) [n:127.0.0.1:37400_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=nemesis&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 156793 INFO (OverseerCollectionConfigSetProcessor-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 156793 INFO (OverseerThreadFactory-918-thread-4-processing-n:127.0.0.1:55460_solr) [n:127.0.0.1:55460_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true [junit4] 2> 156794 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nemesis.shard1.replica_n1, tag=null [junit4] 2> 156794 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.nemesis.shard2.replica_n2, tag=null [junit4] 2> 156794 INFO (qtp171693858-2239) [n:127.0.0.1:55460_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@293050cc: rootName = solr_55460, domain = solr.core.nemesis.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.nemesis.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@657ebaaa [junit4] 2> 156794 INFO (qtp205035341-2217) [n:127.0.0.1:37400_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2bf7884: rootName = [...truncated too long message...] e8 x:localShardsTestColl_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.localShardsTestColl.shard1.replica_n4, tag=2130487290 [junit4] 2> 184970 INFO (coreCloseExecutor-1050-thread-4) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard1 r:core_node8 x:localShardsTestColl_shard1_replica_n4] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2bd898b2: rootName = solr_55460, domain = solr.core.localShardsTestColl.shard1.replica_n4, service url = null, agent id = null] for registry solr.core.localShardsTestColl.shard1.replica_n4 / com.codahale.metrics.MetricRegistry@63232a43 [junit4] 2> 184978 INFO (coreCloseExecutor-1051-thread-8) [n:127.0.0.1:37591_solr c:2nd_collection s:shard2 r:core_node4 x:2nd_collection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.2nd_collection.shard2.leader, tag=650703307 [junit4] 2> 184979 INFO (coreCloseExecutor-1050-thread-4) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard1 r:core_node8 x:localShardsTestColl_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.localShardsTestColl.shard1.leader, tag=2130487290 [junit4] 2> 184979 INFO (coreCloseExecutor-1051-thread-6) [n:127.0.0.1:37591_solr c:multicollection1 s:shard1 r:core_node3 x:multicollection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.multicollection1.shard1.leader, tag=742899696 [junit4] 2> 184979 INFO (coreCloseExecutor-1050-thread-3) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard2 r:core_node15 x:localShardsTestColl_shard2_replica_n9] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.localShardsTestColl.shard2.replica_n9, tag=18663375 [junit4] 2> 184979 INFO (coreCloseExecutor-1050-thread-3) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard2 r:core_node15 x:localShardsTestColl_shard2_replica_n9] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@571ef51a: rootName = solr_55460, domain = solr.core.localShardsTestColl.shard2.replica_n9, service url = null, agent id = null] for registry solr.core.localShardsTestColl.shard2.replica_n9 / com.codahale.metrics.MetricRegistry@cbbe406 [junit4] 2> 184984 INFO (jetty-closer-509-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3375cfa2{/solr,null,UNAVAILABLE} [junit4] 2> 184991 INFO (jetty-closer-509-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1e5fe95d{/solr,null,UNAVAILABLE} [junit4] 2> 184993 INFO (coreCloseExecutor-1050-thread-3) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard2 r:core_node15 x:localShardsTestColl_shard2_replica_n9] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.localShardsTestColl.shard2.leader, tag=18663375 [junit4] 2> 184993 INFO (coreCloseExecutor-1050-thread-2) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard3 r:core_node18 x:localShardsTestColl_shard3_replica_n12] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.localShardsTestColl.shard3.replica_n12, tag=399666305 [junit4] 2> 184993 INFO (coreCloseExecutor-1050-thread-2) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard3 r:core_node18 x:localShardsTestColl_shard3_replica_n12] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@14245288: rootName = solr_55460, domain = solr.core.localShardsTestColl.shard3.replica_n12, service url = null, agent id = null] for registry solr.core.localShardsTestColl.shard3.replica_n12 / com.codahale.metrics.MetricRegistry@4027fe97 [junit4] 2> 185003 INFO (coreCloseExecutor-1050-thread-2) [n:127.0.0.1:55460_solr c:localShardsTestColl s:shard3 r:core_node18 x:localShardsTestColl_shard3_replica_n12] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.localShardsTestColl.shard3.leader, tag=399666305 [junit4] 2> 185003 INFO (coreCloseExecutor-1050-thread-1) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n1, tag=2122669684 [junit4] 2> 185003 INFO (coreCloseExecutor-1050-thread-1) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@9fc34eb: rootName = solr_55460, domain = solr.core.collection1.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.collection1.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@23ac1a8d [junit4] 2> 185009 INFO (coreCloseExecutor-1050-thread-1) [n:127.0.0.1:55460_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader, tag=2122669684 [junit4] 2> 185009 INFO (coreCloseExecutor-1050-thread-8) [n:127.0.0.1:55460_solr c:2nd_collection s:shard1 r:core_node3 x:2nd_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.2nd_collection.shard1.leader, tag=1776203242 [junit4] 2> 185012 INFO (jetty-closer-509-thread-3) [ ] o.a.s.c.Overseer Overseer (id=98985385390309385-127.0.0.1:55460_solr-n_0000000000) closing [junit4] 2> 185012 INFO (OverseerStateUpdate-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:55460_solr [junit4] 2> 185013 WARN (OverseerAutoScalingTriggerThread-98985385390309385-127.0.0.1:55460_solr-n_0000000000) [n:127.0.0.1:55460_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 185019 INFO (jetty-closer-509-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@b628849{/solr,null,UNAVAILABLE} [junit4] 2> 185021 ERROR (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 185021 INFO (SUITE-CloudSolrClientTest-seed#[80E3DB53DBDE942A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45976 45976 [junit4] 2> 190070 INFO (Thread-402) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45976 45976 [junit4] 2> 190072 WARN (Thread-402) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 8 /solr/clusterprops.json [junit4] 2> 8 /solr/aliases.json [junit4] 2> 4 /solr/configs/conf [junit4] 2> 3 /solr/security.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 27 /solr/collections/localShardsTestColl/state.json [junit4] 2> 24 /solr/collections/foo/state.json [junit4] 2> 15 /solr/collections/stale_state_test_col/state.json [junit4] 2> 14 /solr/collections/collection1/state.json [junit4] 2> 14 /solr/collections/2nd_collection/state.json [junit4] 2> 14 /solr/collections/multicollection2/state.json [junit4] 2> 12 /solr/collections/multicollection1/state.json [junit4] 2> 10 /solr/collections/nemesis/state.json [junit4] 2> 8 /solr/clusterstate.json [junit4] 2> 6 /solr/collections/overwrite/state.json [junit4] 2> 2 /solr/overseer_elect/election/98985385390309385-127.0.0.1:55460_solr-n_0000000000 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 8 /solr/live_nodes [junit4] 2> 8 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.impl.CloudSolrClientTest_80E3DB53DBDE942A-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=true): {}, locale=bg-BG, timezone=Africa/Nairobi [junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=3,threads=1,free=118644104,total=483393536 [junit4] 2> NOTE: All tests run in this JVM: [HyperbolicSineEvaluatorTest, TestUpdateRequestCodec, StreamingTest, EmpiricalDistributionEvaluatorTest, JettyWebappTest, FloorEvaluatorTest, StreamExpressionToExpessionTest, TestV1toV2ApiMapper, UsingSolrJRefGuideExamplesTest, CloudSolrClientBuilderTest, UuidEvaluatorTest, ArcSineEvaluatorTest, SineEvaluatorTest, RecursiveEvaluatorTest, ModifiableSolrParamsTest, GraphTest, CommonAdminParamsTest, MultiplyEvaluatorTest, TestSolrProperties, TestCollectionStateWatchers, FieldAnalysisResponseTest, CloudSolrClientMultiConstructorTest, CeilingEvaluatorTest, TestCoreAdmin, CosineEvaluatorTest, NormalDistributionEvaluatorTest, TestXMLEscaping, HttpSolrClientSSLAuthConPoolTest, TestRetryUtil, TestHash, AddEvaluatorTest, SolrExampleStreamingTest, ArrayEvaluatorTest, TestDocumentObjectBinder, SolrExampleStreamingBinaryTest, SolrExampleBinaryTest, SolrExampleXMLTest, SolrExampleJettyTest, SolrExampleEmbeddedTest, TestBatchUpdate, LargeVolumeEmbeddedTest, TestSpellCheckResponse, LargeVolumeJettyTest, TermsResponseTest, TestEmbeddedSolrServer, QueryResponseTest, TestJavaBinCodec, ContentStreamTest, DocumentAnalysisResponseTest, SolrDocumentTest, ClientUtilsTest, NamedListTest, FacetFieldTest, CollectionAdminRequestRequiredParamsTest, GetByIdTest, SolrSchemalessExampleTest, TestLBHttpSolrClient, TestPolicy, CloudSolrClientTest] [junit4] Completed [96/146 (1!)] on J0 in 39.60s, 16 tests, 1 error <<< FAILURES! [...truncated 46531 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
