Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2912/ Java: 64bit/jdk-10.0.1 -XX:+UseCompressedOops -XX:+UseG1GC
7 tests failed. FAILED: org.apache.solr.client.solrj.impl.CloudSolrClientTest.testVersionsAreReturned Error Message: Error from server at http://127.0.0.1:41673/solr/collection1_shard2_replica_n2: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/collection1_shard2_replica_n2/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/collection1_shard2_replica_n2/update. Reason: <pre> Can not find: /solr/collection1_shard2_replica_n2/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> Stack Trace: org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Error from server at http://127.0.0.1:41673/solr/collection1_shard2_replica_n2: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/collection1_shard2_replica_n2/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/collection1_shard2_replica_n2/update. Reason: <pre> Can not find: /solr/collection1_shard2_replica_n2/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> at __randomizedtesting.SeedInfo.seed([21D0F5FFC48BDFE2:D9160CCA5792472A]:0) at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:551) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1016) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:949) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:237) at org.apache.solr.client.solrj.impl.CloudSolrClientTest.testVersionsAreReturned(CloudSolrClientTest.java:725) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:41673/solr/collection1_shard2_replica_n2: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/collection1_shard2_replica_n2/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/collection1_shard2_replica_n2/update. Reason: <pre> Can not find: /solr/collection1_shard2_replica_n2/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> 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.lambda$directUpdate$0(CloudSolrClient.java:528) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1135) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) ... 1 more FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 7 in https://127.0.0.1:34791/solr Stack Trace: java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:34791/solr at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:FFE40DF95FF1B570]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:901) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:566) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 7 in https://127.0.0.1:42941/solr Stack Trace: java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:42941/solr at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:FFE40DF95FF1B570]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:901) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:566) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 7 in https://127.0.0.1:43923/solr Stack Trace: java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:43923/solr at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:FFE40DF95FF1B570]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:901) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:566) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 7 in https://127.0.0.1:40597/solr Stack Trace: java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:40597/solr at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:FFE40DF95FF1B570]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:901) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:566) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery Error Message: Can not find doc 7 in https://127.0.0.1:39787/solr Stack Trace: java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:39787/solr at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:FFE40DF95FF1B570]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:901) at org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:566) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.TestUtilizeNode.test Error Message: Error from server at http://127.0.0.1:41567/solr: create the collection time out:180s Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:41567/solr: create the collection time out:180s at __randomizedtesting.SeedInfo.seed([3E14745572A17FD7:B6404B8FDC5D122F]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) 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.sendRequest(CloudSolrClient.java:1107) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1222) at org.apache.solr.cloud.TestUtilizeNode.test(TestUtilizeNode.java:84) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 12584 lines...] [junit4] Suite: org.apache.solr.cloud.TestUtilizeNode [junit4] 2> 74288 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_3E14745572A17FD7-001/init-core-data-001 [junit4] 2> 74302 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 74304 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 74317 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_3E14745572A17FD7-001/tempDir-001 [junit4] 2> 74317 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 74327 INFO (Thread-207) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 74327 INFO (Thread-207) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 74406 ERROR (Thread-207) [ ] 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> 74427 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:33991 [junit4] 2> 74445 INFO (zkConnectionManagerCallback-528-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 74474 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10 [junit4] 2> 74477 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10 [junit4] 2> 74482 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10 [junit4] 2> 74557 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 74557 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 74557 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 74585 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@130c5ec5{/solr,null,AVAILABLE} [junit4] 2> 74586 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@783a8dbb{HTTP/1.1,[http/1.1]}{127.0.0.1:41567} [junit4] 2> 74586 INFO (jetty-launcher-525-thread-3) [ ] o.e.j.s.Server Started @74650ms [junit4] 2> 74586 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41567} [junit4] 2> 74587 ERROR (jetty-launcher-525-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 74653 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 74653 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 74653 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 74660 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@65d48b4b{/solr,null,AVAILABLE} [junit4] 2> 74661 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4671a6ce{HTTP/1.1,[http/1.1]}{127.0.0.1:41223} [junit4] 2> 74661 INFO (jetty-launcher-525-thread-2) [ ] o.e.j.s.Server Started @74725ms [junit4] 2> 74661 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41223} [junit4] 2> 74661 ERROR (jetty-launcher-525-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 74663 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 74663 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.6.0 [junit4] 2> 74663 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 74663 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 74663 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-10-14T17:49:18.711320Z [junit4] 2> 74663 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 74664 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.6.0 [junit4] 2> 74664 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 74664 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 74664 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-10-14T17:49:18.712134Z [junit4] 2> 74709 INFO (zkConnectionManagerCallback-532-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 74745 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 74745 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 74745 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 74761 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@18e27730{/solr,null,AVAILABLE} [junit4] 2> 74761 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@73f686c2{HTTP/1.1,[http/1.1]}{127.0.0.1:34485} [junit4] 2> 74761 INFO (jetty-launcher-525-thread-1) [ ] o.e.j.s.Server Started @74826ms [junit4] 2> 74761 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34485} [junit4] 2> 74762 ERROR (jetty-launcher-525-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 74762 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 74762 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.6.0 [junit4] 2> 74762 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 74762 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 74762 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-10-14T17:49:18.810471Z [junit4] 2> 74806 INFO (zkConnectionManagerCallback-530-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 74813 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 74813 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 74817 INFO (zkConnectionManagerCallback-534-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 74818 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 75034 INFO (jetty-launcher-525-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33991/solr [junit4] 2> 75105 INFO (jetty-launcher-525-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33991/solr [junit4] 2> 75123 INFO (zkConnectionManagerCallback-542-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75123 INFO (jetty-launcher-525-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33991/solr [junit4] 2> 75123 INFO (zkConnectionManagerCallback-538-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75131 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10022dd1b140004, likely client has closed socket [junit4] 2> 75137 INFO (zkConnectionManagerCallback-546-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75155 INFO (zkConnectionManagerCallback-548-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75156 INFO (zkConnectionManagerCallback-550-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75158 INFO (zkConnectionManagerCallback-552-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75217 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34485_solr [junit4] 2> 75218 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer Overseer (id=72095927075340295-127.0.0.1:34485_solr-n_0000000000) starting [junit4] 2> 75241 INFO (zkConnectionManagerCallback-563-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75249 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33991/solr ready [junit4] 2> 75254 INFO (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34485_solr [junit4] 2> 75276 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34485_solr [junit4] 2> 75277 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 75280 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 75280 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 75280 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 75300 INFO (zkCallback-547-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 75309 INFO (zkCallback-562-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 75312 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 75319 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:34485_solr] [junit4] 2> 75322 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 75323 DEBUG (OverseerAutoScalingTriggerThread-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 75325 DEBUG (ScheduledTrigger-672-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 75334 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34485.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75342 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34485.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75342 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34485.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75344 INFO (jetty-launcher-525-thread-1) [n:127.0.0.1:34485_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_3E14745572A17FD7-001/tempDir-001/node1/. [junit4] 2> 75361 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 75371 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 75371 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 75371 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41223_solr [junit4] 2> 75373 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:41223_solr"} current state version: 0 [junit4] 2> 75373 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:41223_solr [junit4] 2> 75386 INFO (zkCallback-562-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 75386 INFO (zkCallback-547-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 75389 INFO (zkCallback-549-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 75390 INFO (zkCallback-551-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 75392 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 75393 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41567_solr [junit4] 2> 75393 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:41567_solr"} current state version: 0 [junit4] 2> 75393 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:41567_solr [junit4] 2> 75397 INFO (zkCallback-547-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 75402 INFO (zkCallback-549-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 75402 INFO (zkCallback-562-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 75403 INFO (zkCallback-551-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 75408 INFO (zkConnectionManagerCallback-569-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75414 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 75416 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33991/solr ready [junit4] 2> 75416 INFO (zkConnectionManagerCallback-574-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75442 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 75445 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 75448 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33991/solr ready [junit4] 2> 75456 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41223.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75464 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41223.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75464 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 75465 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41223.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75466 INFO (jetty-launcher-525-thread-2) [n:127.0.0.1:41223_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_3E14745572A17FD7-001/tempDir-001/node2/. [junit4] 2> 75506 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41567.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75514 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41567.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75515 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41567.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@232e3167 [junit4] 2> 75516 INFO (jetty-launcher-525-thread-3) [n:127.0.0.1:41567_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_3E14745572A17FD7-001/tempDir-001/node3/. [junit4] 2> 75594 INFO (zkConnectionManagerCallback-578-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75595 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10022dd1b14000d, likely client has closed socket [junit4] 2> 75626 INFO (zkConnectionManagerCallback-583-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75630 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 75631 INFO (SUITE-TestUtilizeNode-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33991/solr ready [junit4] 2> 75638 INFO (qtp88833426-1707) [n:127.0.0.1:41567_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 75672 INFO (qtp88833426-1707) [n:127.0.0.1:41567_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=33 [junit4] 2> 75714 INFO (TEST-TestUtilizeNode.test-seed#[3E14745572A17FD7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 75714 INFO (TEST-TestUtilizeNode.test-seed#[3E14745572A17FD7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 75789 INFO (zkConnectionManagerCallback-587-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 75792 INFO (TEST-TestUtilizeNode.test-seed#[3E14745572A17FD7]) [ ] o.a.s.c.TestUtilizeNode Creating Collection... [junit4] 2> 75792 INFO (qtp88833426-1699) [n:127.0.0.1:41567_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&maxShardsPerNode=2&name=utilizenodecoll&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 75805 INFO (OverseerThreadFactory-674-thread-2-processing-n:127.0.0.1:34485_solr) [n:127.0.0.1:34485_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection utilizenodecoll [junit4] 2> 75805 INFO (OverseerCollectionConfigSetProcessor-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_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> 75808 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "name":"utilizenodecoll", [junit4] 2> "fromApi":"true", [junit4] 2> "collection.configName":"conf1", [junit4] 2> "numShards":"2", [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "nrtReplicas":"2", [junit4] 2> "stateFormat":"2", [junit4] 2> "replicationFactor":"2", [junit4] 2> "operation":"create"} current state version: 0 [junit4] 2> 75808 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: utilizenodecoll [junit4] 2> 75808 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/utilizenodecoll/state.json [junit4] 2> 75908 DEBUG (OverseerThreadFactory-674-thread-2-processing-n:127.0.0.1:34485_solr) [n:127.0.0.1:34485_solr ] o.a.s.c.s.c.a.PolicyHelper Creating a new session [junit4] 2> 75912 INFO (qtp88833426-1703) [n:127.0.0.1:41567_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0 [junit4] 2> 75919 INFO (qtp1613134660-1725) [n:127.0.0.1:34485_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0 [junit4] 2> 75924 INFO (qtp1931659433-1713) [n:127.0.0.1:41223_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0 [junit4] 2> 75924 DEBUG (OverseerThreadFactory-674-thread-2-processing-n:127.0.0.1:34485_solr) [n:127.0.0.1:34485_solr ] o.a.s.c.s.c.a.PolicyHelper New session created [junit4] 2> 75933 DEBUG (OverseerThreadFactory-674-thread-2-processing-n:127.0.0.1:34485_solr) [n:127.0.0.1:34485_solr ] o.a.s.c.s.c.a.PolicyHelper returnSession, curr-time 584917328 sessionWrapper.createTime 584917319811638, this.sessionWrapper.createTime 584917319811638 [junit4] 2> 75938 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 75938 INFO (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 75942 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{}} [junit4] 2> 75942 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 75945 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 75945 INFO (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 75946 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 75946 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 75948 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 75948 INFO (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 75961 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{}} [junit4] 2> 75961 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 75968 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} current state version: 0 [junit4] 2> 75968 INFO (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 75969 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{"core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 75969 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node8":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}} [junit4] 2> 76070 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/utilizenodecoll/state.json version: 0 [junit4] 2> 76073 INFO (qtp1931659433-1700) [n:127.0.0.1:41223_solr x:utilizenodecoll_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n1&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 76076 INFO (qtp88833426-1701) [n:127.0.0.1:41567_solr x:utilizenodecoll_shard2_replica_n7] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n7&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 76078 INFO (qtp1613134660-1702) [n:127.0.0.1:34485_solr x:utilizenodecoll_shard1_replica_n3] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n3&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 76078 INFO (qtp1613134660-1702) [n:127.0.0.1:34485_solr x:utilizenodecoll_shard1_replica_n3] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 76081 INFO (qtp88833426-1697) [n:127.0.0.1:41567_solr x:utilizenodecoll_shard2_replica_n4] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n4&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 76100 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "core_node_name":"core_node5", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 76100 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "core_node_name":"core_node5", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} [junit4] 2> 76101 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{"core":"utilizenodecoll_shard1_replica_n3","base_url":"http://127.0.0.1:34485/solr","node_name":"127.0.0.1:34485_solr","state":"down","type":"NRT","force_set_state":"false"} [junit4] 2> 76102 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"2", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"2", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}, [junit4] 2> "shard2":{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node8":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}}}}} [junit4] 2> 76111 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = { [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "core_node_name":"core_node8", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 76111 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "core_node_name":"core_node8", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} [junit4] 2> 76111 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node8:{"core":"utilizenodecoll_shard2_replica_n7","base_url":"http://127.0.0.1:41567/solr","node_name":"127.0.0.1:41567_solr","state":"down","type":"NRT","force_set_state":"false"} [junit4] 2> 76111 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"2", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"2", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}, [junit4] 2> "shard2":{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node8":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}}} [junit4] 2> 76112 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "core_node_name":"core_node2", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "node_name":"127.0.0.1:41223_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 76112 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "core_node_name":"core_node2", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "node_name":"127.0.0.1:41223_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} [junit4] 2> 76112 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{"core":"utilizenodecoll_shard1_replica_n1","base_url":"http://127.0.0.1:41223/solr","node_name":"127.0.0.1:41223_solr","state":"down","type":"NRT","force_set_state":"false"} [junit4] 2> 76112 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"2", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"2", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "node_name":"127.0.0.1:41223_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}, [junit4] 2> "shard2":{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "state":"down", [junit4] 2> "node_name":null, [junit4] 2> "type":"NRT"}, [junit4] 2> "core_node8":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}}} [junit4] 2> 76117 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = { [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "core_node_name":"core_node6", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 76117 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "core_node_name":"core_node6", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"utilizenodecoll", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false", [junit4] 2> "operation":"state"} [junit4] 2> 76117 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{"core":"utilizenodecoll_shard2_replica_n4","base_url":"http://127.0.0.1:41567/solr","node_name":"127.0.0.1:41567_solr","state":"down","type":"NRT","force_set_state":"false"} [junit4] 2> 76117 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={ [junit4] 2> "pullReplicas":"0", [junit4] 2> "replicationFactor":"2", [junit4] 2> "router":{"name":"compositeId"}, [junit4] 2> "maxShardsPerNode":"2", [junit4] 2> "autoAddReplicas":"false", [junit4] 2> "nrtReplicas":"2", [junit4] 2> "tlogReplicas":"0", [junit4] 2> "shards":{ [junit4] 2> "shard1":{ [junit4] 2> "range":"80000000-ffffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node2":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n1", [junit4] 2> "base_url":"http://127.0.0.1:41223/solr", [junit4] 2> "node_name":"127.0.0.1:41223_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}, [junit4] 2> "core_node5":{ [junit4] 2> "core":"utilizenodecoll_shard1_replica_n3", [junit4] 2> "base_url":"http://127.0.0.1:34485/solr", [junit4] 2> "node_name":"127.0.0.1:34485_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}, [junit4] 2> "shard2":{ [junit4] 2> "range":"0-7fffffff", [junit4] 2> "state":"active", [junit4] 2> "replicas":{ [junit4] 2> "core_node6":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n4", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}, [junit4] 2> "core_node8":{ [junit4] 2> "core":"utilizenodecoll_shard2_replica_n7", [junit4] 2> "base_url":"http://127.0.0.1:41567/solr", [junit4] 2> "node_name":"127.0.0.1:41567_solr", [junit4] 2> "state":"down", [junit4] 2> "type":"NRT", [junit4] 2> "force_set_state":"false"}}}}} [junit4] 2> 76225 DEBUG (OverseerStateUpdate-72095927075340295-127.0.0.1:34485_solr-n_0000000000) [n:127.0.0.1:34485_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/utilizenodecoll/state.json version: 1 [junit4] 2> 76327 DEBUG (ScheduledTrigger-672-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 [junit4] 2> 77107 INFO (qtp1613134660-1702) [n:127.0.0.1:34485_solr c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0 [junit4] 2> 77111 INFO (qtp1613134660-1702) [n:127.0.0.1:34485_solr c:utilizenodecoll s:shard1 r:core_node5 x:utilizenodecoll_shard1_replica_n3] o.a.s.s.IndexSchema [utilizenodecoll_shard1_replica_n3] Schema name=cloud-dynamic [junit4] 2> 77117 INFO (qtp1931659433-1700) [n:127.0.0.1:41223_solr c:utilizenodecoll s:shard1 r:core_node2 x:utilizenodecoll_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0 [junit4] 2> 77123 INFO (qtp1931659433-1700) [n:127.0.0.1:41223_solr c:utilizenodecoll s:shard1 r:core_node2 x:utilizenodecoll_shard1_replica_n1] o.a.s.s.IndexSchema [utilizeno [...truncated too long message...] null [junit4] 2> 225821 INFO (jetty-closer-336-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@fafea5b: rootName = solr_41095, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3b29372c [junit4] 2> 225822 INFO (jetty-closer-336-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41095_solr [junit4] 2> 225823 INFO (jetty-closer-336-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 225823 INFO (zkCallback-443-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 225823 INFO (zkCallback-436-thread-4) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 225823 INFO (zkCallback-455-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 225824 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10023180350001e, likely client has closed socket [junit4] 2> 225825 INFO (jetty-closer-336-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72096180079689753-127.0.0.1:41095_solr-n_0000000005) closing [junit4] 2> 225825 INFO (OverseerStateUpdate-72096180079689753-127.0.0.1:41095_solr-n_0000000005) [n:127.0.0.1:41095_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:41095_solr [junit4] 2> 225825 WARN (OverseerAutoScalingTriggerThread-72096180079689753-127.0.0.1:41095_solr-n_0000000005) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 225827 INFO (zkCallback-455-thread-2) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43923_solr [junit4] 2> 225827 INFO (jetty-closer-336-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@50d4049c{/solr,null,UNAVAILABLE} [junit4] 2> 225827 INFO (jetty-closer-336-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 227324 WARN (zkCallback-462-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 227325 INFO (jetty-closer-336-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@513821d1{/solr,null,UNAVAILABLE} [junit4] 2> 227325 INFO (jetty-closer-336-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 227326 ERROR (SUITE-TestTlogReplica-seed#[3E14745572A17FD7]-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> 227326 INFO (SUITE-TestTlogReplica-seed#[3E14745572A17FD7]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44941 44941 [junit4] 2> 227355 INFO (Thread-210) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44941 44941 [junit4] 2> 227356 WARN (Thread-210) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 30 /solr/configs/conf [junit4] 2> 30 /solr/collections/tlog_replica_test_create_delete/terms/shard2 [junit4] 2> 29 /solr/collections/tlog_replica_test_create_delete/terms/shard1 [junit4] 2> 19 /solr/collections/tlog_replica_test_recovery/terms/shard1 [junit4] 2> 19 /solr/collections/tlog_replica_test_remove_leader/terms/shard1 [junit4] 2> 17 /solr/collections/tlog_replica_test_basic_leader_election/terms/shard1 [junit4] 2> 16 /solr/collections/tlog_replica_test_kill_leader/terms/shard1 [junit4] 2> 16 /solr/collections/tlog_replica_test_kill_tlog_replica/terms/shard1 [junit4] 2> 15 /solr/aliases.json [junit4] 2> 13 /solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/terms/shard1 [junit4] 2> 11 /solr/collections/tlog_replica_test_only_leader_indexes/terms/shard1 [junit4] 2> 10 /solr/collections/tlog_replica_test_delete_by_id/terms/shard1 [junit4] 2> 7 /solr/security.json [junit4] 2> 7 /solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard1 [junit4] 2> 7 /solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard2 [junit4] 2> 4 /solr/collections/tlog_replica_test_add_docs/terms/shard1 [junit4] 2> 4 /solr/collections/tlog_replica_test_real_time_get/terms/shard1 [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 20 /solr/collections/tlog_replica_test_create_delete/state.json [junit4] 2> 15 /solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json [junit4] 2> 15 /solr/clusterprops.json [junit4] 2> 15 /solr/clusterstate.json [junit4] 2> 13 /solr/collections/tlog_replica_test_recovery/state.json [junit4] 2> 11 /solr/collections/tlog_replica_test_basic_leader_election/state.json [junit4] 2> 9 /solr/collections/tlog_replica_test_remove_leader/state.json [junit4] 2> 8 /solr/collections/tlog_replica_test_kill_leader/state.json [junit4] 2> 7 /solr/collections/tlog_replica_test_kill_tlog_replica/state.json [junit4] 2> 4 /solr/autoscaling.json [junit4] 2> 3 /solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json [junit4] 2> 3 /solr/collections/tlog_replica_test_only_leader_indexes/state.json [junit4] 2> 3 /solr/collections/tlog_replica_test_delete_by_id/state.json [junit4] 2> 2 /solr/overseer_elect/election/72096180079689732-127.0.0.1:43923_solr-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_add_docs/state.json [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72096180079689749-core_node5-n_0000000000 [junit4] 2> 2 /solr/overseer_elect/election/72096180079689741-127.0.0.1:41095_solr-n_0000000002 [junit4] 2> 2 /solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/72096180079689753-core_node3-n_0000000000 [junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/72096180079689753-core_node11-n_0000000001 [junit4] 2> 2 /solr/collections/tlog_replica_test_real_time_get/state.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 15 /solr/live_nodes [junit4] 2> 15 /solr/collections [junit4] 2> 4 /solr/overseer/queue [junit4] 2> 4 /solr/autoscaling/events/.scheduled_maintenance [junit4] 2> 4 /solr/autoscaling/events/.auto_add_replicas [junit4] 2> 4 /solr/overseer/queue-work [junit4] 2> 4 /solr/overseer/collection-queue-work [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestTlogReplica_3E14745572A17FD7-002 [junit4] 2> Oct 14, 2018 6:55:19 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=ca-ES-VALENCIA, timezone=Pacific/Pago_Pago [junit4] 2> NOTE: Linux 4.15.0-36-generic amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=8,threads=1,free=286105624,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestUtilizeNode, TestTlogReplica, TestUtilizeNode, TestTlogReplica] [junit4] Completed [9/10 (4!)] on J1 in 100.90s, 13 tests, 1 failure <<< FAILURES! [...truncated 30 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1567: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: There were test failures: 10 suites, 70 tests, 4 failures [seed: 3E14745572A17FD7] Total time: 4 minutes 0 seconds [repro] Setting last failure code to 256 [repro] Failures: [repro] 0/5 failed: org.apache.solr.client.solrj.impl.CloudSolrClientTest [repro] 0/5 failed: org.apache.solr.cloud.TestUtilizeNode [repro] 4/5 failed: org.apache.solr.cloud.TestTlogReplica [repro] Exiting with code 256 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=6727a9312ce0f3913cd823d4ef0721d8405aef89, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux [WARNINGS] Computing warning deltas based on reference build #2911 Recording test results Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
