Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2216/
7 tests failed. FAILED: org.apache.solr.cloud.MultiThreadedOCPTest.test Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E:6AC1331E685BF8E6]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.cloud.MultiThreadedOCPTest.testFillWorkQueue(MultiThreadedOCPTest.java:112) at org.apache.solr.cloud.MultiThreadedOCPTest.test(MultiThreadedOCPTest.java:67) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.TestCryptoKeys.test Error Message: { "responseHeader":{ "status":500, "QTime":31219}, "errorMessages":["4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]\n"], "WARNING":"This response format is experimental. It is likely to change in the future.", "error":{ "metadata":[ "error-class","org.apache.solr.common.SolrException", "root-error-class","org.apache.solr.common.SolrException"], "msg":"4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]", "trace":"org.apache.solr.common.SolrException: 4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]\n\tat org.apache.solr.handler.SolrConfigHandler.waitForAllReplicasState(SolrConfigHandler.java:771)\n\tat org.apache.solr.handler.SolrConfigHandler.access$400(SolrConfigHandler.java:101)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:502)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:345)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:158)\n\tat org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:136)\n\tat org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)\n\tat org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)\n\tat org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)\n\tat org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)\n\tat org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)\n\tat org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)\n\tat org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)\n\tat org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)\n\tat org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)\n\tat org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)\n\tat org.eclipse.jetty.server.Server.handle(Server.java:534)\n\tat org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)\n\tat org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)\n\tat org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)\n\tat org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)\n\tat org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)\n\tat java.lang.Thread.run(Thread.java:748)\n", "code":500}} Stack Trace: java.lang.AssertionError: { "responseHeader":{ "status":500, "QTime":31219}, "errorMessages":["4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]\n"], "WARNING":"This response format is experimental. It is likely to change in the future.", "error":{ "metadata":[ "error-class","org.apache.solr.common.SolrException", "root-error-class","org.apache.solr.common.SolrException"], "msg":"4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]", "trace":"org.apache.solr.common.SolrException: 4 out of 5 the property overlay to be of version 4 within 30 seconds! Failed cores: [http://127.0.0.1:56049/wt/l/collection1_shard1_replica_n21/, http://127.0.0.1:48311/wt/l/collection1_shard1_replica_n23/, http://127.0.0.1:54659/wt/l/collection1_shard1_replica_n25/, http://127.0.0.1:33473/wt/l/collection1_shard1_replica_n27/]\n\tat org.apache.solr.handler.SolrConfigHandler.waitForAllReplicasState(SolrConfigHandler.java:771)\n\tat org.apache.solr.handler.SolrConfigHandler.access$400(SolrConfigHandler.java:101)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:502)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:345)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:158)\n\tat org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:136)\n\tat org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)\n\tat org.apache.solr.core.SolrCore.execute(SolrCore.java:2503)\n\tat org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:710)\n\tat org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)\n\tat org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)\n\tat org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)\n\tat org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)\n\tat org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)\n\tat org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)\n\tat org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)\n\tat org.eclipse.jetty.server.Server.handle(Server.java:534)\n\tat org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)\n\tat org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)\n\tat org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)\n\tat org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)\n\tat org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)\n\tat org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)\n\tat java.lang.Thread.run(Thread.java:748)\n", "code":500}} at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E:6AC1331E685BF8E6]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNull(Assert.java:551) at org.apache.solr.core.TestSolrConfigHandler.runConfigCommand(TestSolrConfigHandler.java:185) at org.apache.solr.cloud.TestCryptoKeys.test(TestCryptoKeys.java:200) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv_stored Error Message: java.lang.RuntimeException: Error from server at http://127.0.0.1:36010/solr/test_col: Cannot talk to ZooKeeper - Updates are disabled. Stack Trace: java.util.concurrent.ExecutionException: java.lang.RuntimeException: Error from server at http://127.0.0.1:36010/solr/test_col: Cannot talk to ZooKeeper - Updates are disabled. at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E:70A96D407AE0A8C6]:0) at java.util.concurrent.FutureTask.report(FutureTask.java:122) at java.util.concurrent.FutureTask.get(FutureTask.java:192) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.checkField(TestStressCloudBlindAtomicUpdates.java:283) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv_stored(TestStressCloudBlindAtomicUpdates.java:205) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Caused by: java.lang.RuntimeException: Error from server at http://127.0.0.1:36010/solr/test_col: Cannot talk to ZooKeeper - Updates are disabled. at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.run(TestStressCloudBlindAtomicUpdates.java:411) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ... 1 more Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:36010/solr/test_col: Cannot talk to ZooKeeper - Updates are disabled. 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.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.doRandomAtomicUpdate(TestStressCloudBlindAtomicUpdates.java:370) at org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.run(TestStressCloudBlindAtomicUpdates.java:399) ... 6 more FAILED: org.apache.solr.cloud.TestStressInPlaceUpdates.stressTest Error Message: Captured an uncaught exception in thread: Thread[id=26677, name=WRITER16, state=RUNNABLE, group=TGRP-TestStressInPlaceUpdates] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=26677, name=WRITER16, state=RUNNABLE, group=TGRP-TestStressInPlaceUpdates] Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:53836/collection1: Cannot talk to ZooKeeper - Updates are disabled. at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E]:0) at org.apache.solr.cloud.TestStressInPlaceUpdates$1.run(TestStressInPlaceUpdates.java:306) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:53836/collection1: Cannot talk to ZooKeeper - Updates are disabled. 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.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.cloud.TestStressInPlaceUpdates.deleteDocAndGetVersion(TestStressInPlaceUpdates.java:570) at org.apache.solr.cloud.TestStressInPlaceUpdates$1.run(TestStressInPlaceUpdates.java:218) FAILED: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi Error Message: expected:<1> but was:<0> Stack Trace: java.lang.AssertionError: expected:<1> but was:<0> at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E:B5BCF7711D557705]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:724) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testNodeMarkersRegistration Error Message: Path /autoscaling/nodeAdded/127.0.0.1:44910_solr wasn't created Stack Trace: java.lang.AssertionError: Path /autoscaling/nodeAdded/127.0.0.1:44910_solr wasn't created at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E:FA2F84C8C89258F1]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testNodeMarkersRegistration(TriggerIntegrationTest.java:930) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.security.BasicAuthIntegrationTest Error Message: Error from server at https://127.0.0.1:33874/solr: KeeperErrorCode = NoNode for /overseer/collection-queue-work/qnr-0000000000 Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:33874/solr: KeeperErrorCode = NoNode for /overseer/collection-queue-work/qnr-0000000000 at __randomizedtesting.SeedInfo.seed([E2950CC4C6A7951E]: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:1103) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.security.BasicAuthIntegrationTest.setupCluster(BasicAuthIntegrationTest.java:82) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 12302 lines...] [junit4] Suite: org.apache.solr.security.BasicAuthIntegrationTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.security.BasicAuthIntegrationTest_E2950CC4C6A7951E-001/init-core-data-001 [junit4] 2> 2060537 WARN (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5 [junit4] 2> 2060537 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2060560 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 2060560 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2060561 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.security.BasicAuthIntegrationTest_E2950CC4C6A7951E-001/tempDir-001 [junit4] 2> 2060561 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2060576 INFO (Thread-792) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2060576 INFO (Thread-792) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2062880 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:50363 [junit4] 2> 2062888 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Exception causing close of session 0x0 due to java.io.IOException: ZooKeeperServer not running [junit4] 2> 2062944 ERROR (Thread-792) [ ] 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> 2064180 INFO (zkConnectionManagerCallback-905-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2064193 INFO (jetty-launcher-902-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2064209 INFO (jetty-launcher-902-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2064216 INFO (jetty-launcher-902-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 2064224 INFO (jetty-launcher-902-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3688583e{/solr,null,AVAILABLE} [junit4] 2> 2064304 INFO (jetty-launcher-902-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d542754{/solr,null,AVAILABLE} [junit4] 2> 2064305 INFO (jetty-launcher-902-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4e52f2ba{SSL,[ssl, http/1.1]}{127.0.0.1:33874} [junit4] 2> 2064305 INFO (jetty-launcher-902-thread-2) [ ] o.e.j.s.Server Started @2087227ms [junit4] 2> 2064305 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33874} [junit4] 2> 2064305 ERROR (jetty-launcher-902-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2064306 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2064306 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2064306 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2064306 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-09T23:23:09.910Z [junit4] 2> 2064472 INFO (jetty-launcher-902-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7170a3fa{/solr,null,AVAILABLE} [junit4] 2> 2064472 INFO (jetty-launcher-902-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@478102a5{SSL,[ssl, http/1.1]}{127.0.0.1:40820} [junit4] 2> 2064472 INFO (jetty-launcher-902-thread-3) [ ] o.e.j.s.Server Started @2087394ms [junit4] 2> 2064472 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40820} [junit4] 2> 2064473 ERROR (jetty-launcher-902-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2064473 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2064473 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2064473 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2064473 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-09T23:23:10.077Z [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2aaa3967{SSL,[ssl, http/1.1]}{127.0.0.1:54577} [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.e.j.s.Server Started @2087396ms [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54577} [junit4] 2> 2064474 ERROR (jetty-launcher-902-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2064474 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-09T23:23:10.078Z [junit4] 2> 2064696 INFO (zkConnectionManagerCallback-907-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2064716 INFO (zkConnectionManagerCallback-909-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2064800 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2064804 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2064804 INFO (zkConnectionManagerCallback-911-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2064824 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2066081 INFO (jetty-launcher-902-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50363/solr [junit4] 2> 2066296 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1603d96e94c0002, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2067242 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1603d96e94c0003, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2067308 INFO (zkConnectionManagerCallback-915-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067332 INFO (jetty-launcher-902-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50363/solr [junit4] 2> 2067336 INFO (jetty-launcher-902-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50363/solr [junit4] 2> 2067397 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067417 INFO (zkConnectionManagerCallback-919-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067441 INFO (zkConnectionManagerCallback-925-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067442 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067508 INFO (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2067539 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2067544 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33874_solr [junit4] 2> 2067548 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer Overseer (id=99146910170611721-127.0.0.1:33874_solr-n_0000000000) starting [junit4] 2> 2067600 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33874_solr [junit4] 2> 2067670 INFO (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2067828 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2067860 INFO (zkCallback-920-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2067991 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54577_solr [junit4] 2> 2068068 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2068084 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2068096 INFO (zkCallback-929-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2068132 INFO (zkCallback-920-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2068136 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40820_solr [junit4] 2> 2068137 INFO (zkCallback-929-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2068160 INFO (zkCallback-920-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2068308 INFO (zkCallback-926-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2069042 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40820.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069051 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33874.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069156 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40820.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069156 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40820.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069254 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33874.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069254 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33874.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2069261 INFO (jetty-launcher-902-thread-3) [n:127.0.0.1:40820_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.security.BasicAuthIntegrationTest_E2950CC4C6A7951E-001/tempDir-001/node3/. [junit4] 2> 2069261 INFO (jetty-launcher-902-thread-2) [n:127.0.0.1:33874_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.security.BasicAuthIntegrationTest_E2950CC4C6A7951E-001/tempDir-001/node2/. [junit4] 2> 2070425 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54577.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2071215 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54577.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2071215 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54577.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@524e87e6 [junit4] 2> 2071248 INFO (jetty-launcher-902-thread-1) [n:127.0.0.1:54577_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.security.BasicAuthIntegrationTest_E2950CC4C6A7951E-001/tempDir-001/node1/. [junit4] 2> 2073256 INFO (zkConnectionManagerCallback-935-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2073260 INFO (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2073260 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2073261 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50363/solr ready [junit4] 2> 2073771 INFO (qtp1881942268-4861) [n:127.0.0.1:33874_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=authCollection&nrtReplicas=1&action=CREATE&numShards=3&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2073824 INFO (OverseerThreadFactory-1824-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.CreateCollectionCmd Create collection authCollection [junit4] 2> 2074145 INFO (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"authCollection_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:54577/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2074145 INFO (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"authCollection_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:40820/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2074173 INFO (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard3", [junit4] 2> "core":"authCollection_shard3_replica_n5", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:33874/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 2074907 INFO (qtp1881942268-4864) [n:127.0.0.1:33874_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=authCollection_shard3_replica_n5&action=CREATE&numShards=3&collection=authCollection&shard=shard3&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2074907 INFO (qtp1881942268-4864) [n:127.0.0.1:33874_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2075250 INFO (zkCallback-929-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075250 INFO (zkCallback-929-thread-2-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075522 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=authCollection_shard1_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2075522 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2075631 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=authCollection_shard2_replica_n2&action=CREATE&numShards=3&collection=authCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2075632 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2075869 INFO (zkCallback-920-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075869 INFO (zkCallback-929-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075869 INFO (zkCallback-926-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075870 INFO (zkCallback-929-thread-3-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075871 INFO (zkCallback-920-thread-2-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2075871 INFO (zkCallback-926-thread-2-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 2076078 INFO (qtp1881942268-4864) [n:127.0.0.1:33874_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n5] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2095176 WARN (jetty-launcher-902-thread-2-SendThread(127.0.0.1:50363)) [n:127.0.0.1:33874_solr ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 19100ms for sessionid 0x1603d96e94c0009 [junit4] 2> 2095188 WARN (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker-SendThread(127.0.0.1:50363)) [ ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 21324ms for sessionid 0x1603d96e94c000b [junit4] 2> 2095176 WARN (jetty-launcher-902-thread-1-SendThread(127.0.0.1:50363)) [n:127.0.0.1:54577_solr ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 19305ms for sessionid 0x1603d96e94c0006 [junit4] 2> 2095176 WARN (jetty-launcher-902-thread-3-SendThread(127.0.0.1:50363)) [n:127.0.0.1:40820_solr ] o.a.z.ClientCnxn Client session timed out, have not heard from server in 19305ms for sessionid 0x1603d96e94c0008 [junit4] 2> 2095516 WARN (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@41d2bce3 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None [junit4] 2> 2095572 WARN (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ConnectionManager zkClient has disconnected [junit4] 2> 2095416 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1603d96e94c0009, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2095573 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1603d96e94c0006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2095573 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1603d96e94c0008, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2095677 WARN (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@412ecff8 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None [junit4] 2> 2095677 WARN (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager zkClient has disconnected [junit4] 2> 2095677 WARN (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16e6d60 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None [junit4] 2> 2095677 WARN (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager zkClient has disconnected [junit4] 2> 2095742 WARN (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@567c2252 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Disconnected type:None path:null path: null type: None [junit4] 2> 2095742 WARN (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has disconnected [junit4] 2> 2097128 WARN (jetty-launcher-902-thread-2-SendThread(127.0.0.1:50363)) [n:127.0.0.1:33874_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session 0x1603d96e94c0009 has expired [junit4] 2> 2097131 WARN (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@41d2bce3 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Expired type:None path:null path: null type: None [junit4] 2> 2097131 WARN (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper... [junit4] 2> 2097131 INFO (zkConnectionManagerCallback-930-thread-1-processing-n:127.0.0.1:33874_solr) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer Overseer (id=99146910170611721-127.0.0.1:33874_solr-n_0000000000) closing [junit4] 2> 2097132 WARN (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer Solr cannot talk to ZK, exiting Overseer main queue loop [junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer/queue [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1532) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$getChildren$4(SolrZkClient.java:327) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:327) [junit4] 2> at org.apache.solr.cloud.ZkDistributedQueue.fetchZkChildren(ZkDistributedQueue.java:410) [junit4] 2> at org.apache.solr.cloud.ZkDistributedQueue.firstChild(ZkDistributedQueue.java:387) [junit4] 2> at org.apache.solr.cloud.ZkDistributedQueue.peekElements(ZkDistributedQueue.java:441) [junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2097132 INFO (OverseerStateUpdate-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:33874_solr [junit4] 2> 2097152 WARN (SUITE-BasicAuthIntegrationTest-seed#[E2950CC4C6A7951E]-worker-SendThread(127.0.0.1:50363)) [ ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session 0x1603d96e94c000b has expired [junit4] 2> 2097393 INFO (OverseerCollectionConfigSetProcessor-99146910170611721-127.0.0.1:33874_solr-n_0000000000) [n:127.0.0.1:33874_solr ] o.a.s.c.OverseerTaskProcessor According to ZK I (id=99146910170611721-127.0.0.1:33874_solr-n_0000000000) am no longer a leader. [junit4] 2> 2097393 WARN (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@567c2252 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Expired type:None path:null path: null type: None [junit4] 2> 2097393 WARN (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper... [junit4] 2> 2097393 WARN (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one... [junit4] 2> 2097413 INFO (zkConnectionManagerCallback-939-thread-1-EventThread) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2097413 INFO (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager Connection with ZooKeeper reestablished. [junit4] 2> 2097414 INFO (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0) [junit4] 2> 2097416 INFO (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to ZooKeeper [junit4] 2> 2097416 INFO (zkConnectionManagerCallback-939-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient Connected:true [junit4] 2> 2097489 ERROR (OverseerExitThread) [n:127.0.0.1:33874_solr ] o.a.s.c.Overseer could not read the data [junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/leader [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1212) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$getData$5(SolrZkClient.java:339) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:339) [junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:301) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2097535 WARN (jetty-launcher-902-thread-3-SendThread(127.0.0.1:50363)) [n:127.0.0.1:40820_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session 0x1603d96e94c0008 has expired [junit4] 2> 2097535 WARN (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@412ecff8 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Expired type:None path:null path: null type: None [junit4] 2> 2097535 WARN (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper... [junit4] 2> 2097535 WARN (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one... [junit4] 2> 2097536 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr-EventThread) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2097536 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ConnectionManager Connection with ZooKeeper reestablished. [junit4] 2> 2097536 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.ZkController ZooKeeper session re-connected ... refreshing core states after session expiration. [junit4] 2> 2097537 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0) [junit4] 2> 2097612 WARN (jetty-launcher-902-thread-1-SendThread(127.0.0.1:50363)) [n:127.0.0.1:54577_solr ] o.a.z.ClientCnxn Unable to reconnect to ZooKeeper service, session 0x1603d96e94c0006 has expired [junit4] 2> 2097613 WARN (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16e6d60 name: ZooKeeperConnection Watcher:127.0.0.1:50363/solr got event WatchedEvent state:Expired type:None path:null path: null type: None [junit4] 2> 2097613 WARN (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper... [junit4] 2> 2097613 WARN (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.DefaultConnectionStrategy Connection expired - starting a new one... [junit4] 2> 2097654 ERROR (qtp470975523-4872) [n:127.0.0.1:40820_solr c:authCollection s:shard2 r:core_node4 x:authCollection_shard2_replica_n2] o.a.s.c.CloudConfigSetService null:org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/authCollection [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1102) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$exists$3(SolrZkClient.java:315) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:315) [junit4] 2> at org.apache.solr.cloud.CloudConfigSetService.createCoreResourceLoader(CloudConfigSetService.java:44) [junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:75) [junit4] 2> at org.apache.solr.core.CoreContainer.getConfigSet(CoreContainer.java:1085) [junit4] 2> at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1037) [junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:952) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 2097684 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr-EventThread) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2097684 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager Connection with ZooKeeper reestablished. [junit4] 2> 2097684 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.ZkController ZooKeeper session re-connected ... refreshing core states after session expiration. [junit4] 2> 2097685 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0) [junit4] 2> 2097860 ERROR (qtp2137319504-4853) [n:127.0.0.1:54577_solr c:authCollection s:shard1 r:core_node3 x:authCollection_shard1_replica_n1] o.a.s.c.CloudConfigSetService null:org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/authCollection [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1102) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$exists$3(SolrZkClient.java:315) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:315) [junit4] 2> at org.apache.solr.cloud.CloudConfigSetService.createCoreResourceLoader(CloudConfigSetService.java:44) [junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:75) [junit4] 2> at org.apache.solr.core.CoreContainer.getConfigSet(CoreContainer.java:1085) [junit4] 2> at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1037) [junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:952) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389) [junit4] 2> at org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:735) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:716) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:497) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:251) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108) [junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 2097864 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40820_solr [junit4] 2> 2097866 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.Overseer Overseer (id=99146910170611725-127.0.0.1:40820_solr-n_0000000003) starting [junit4] 2> 2097902 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54577_solr [junit4] 2> 2097908 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr c:authCollection s:shard2 r:core_node4 x:authCollection_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2097908 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.DefaultConnectionStrategy Reconnected to ZooKeeper [junit4] 2> 2097908 INFO (zkConnectionManagerCallback-921-thread-1-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ConnectionManager zkClient Connected:true [junit4] 2> 2097926 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr c:authCollection s:shard1 r:core_node3 x:authCollection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2097928 INFO (zkCallback-938-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2097968 INFO (zkConnectionManagerCallback-927-thread-1-processing-n:127.0.0.1:40820_solr) [n:127.0.0.1:40820_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40820_solr [junit4] 2> 2097968 INFO (OverseerStateUpdate-99146910170611725-127.0.0.1:40820_solr-n_0000000003) [n:127.0.0.1:40820_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2097986 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr c:authCollection s:shard2 r:core_node4 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema [authCollection_shard2_replica_n2] Schema name=minimal [junit4] 2> 2098005 INFO (zkCallback-920-thread-5-processing-n:127.0.0.1:54577_solr) [n:127.0.0.1:54577_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2098054 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr c:authCollection s:shard1 r:core_node3 x:authCollection_shard1_replica_n1] o.a.s.s.IndexSchema [authCollection_shard1_replica_n1] Schema name=minimal [junit4] 2> 2098056 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr c:authCollection s:shard1 r:core_node3 x:authCollection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2098056 INFO (qtp2137319504-4853) [n:127.0.0.1:54577_solr c:authCollection s:shard1 r:core_node3 x:authCollection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard1_replica_n1' using configuration from collection authCollection, trusted=true [junit4] 2> 2098056 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr c:authCollection s:shard2 r:core_node4 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 2098057 INFO (qtp470975523-4872) [n:127.0.0.1:40820_solr c:authCollection s:shard2 r:core_node4 x:authCollection_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard2_replica_n2' using configuration from collection authCollection, tr [...truncated too long message...] 2> 8937980 INFO (zkCallback-3221-thread-4-processing-n:127.0.0.1:42189_solr) [n:127.0.0.1:42189_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/readApiTestViolations/state.json] for collection [readApiTestViolations] has occurred - updating... (live nodes size: [0]) [junit4] 2> 8937982 INFO (coreCloseExecutor-7468-thread-2) [n:127.0.0.1:46907_solr c:readApiTestViolations s:shard1 r:core_node9 x:readApiTestViolations_shard1_replica_n6] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=2025731363 [junit4] 2> 8937983 INFO (coreCloseExecutor-7468-thread-3) [n:127.0.0.1:46907_solr c:readApiTestViolations s:shard1 r:core_node5 x:readApiTestViolations_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=730303354 [junit4] 2> 8937983 INFO (coreCloseExecutor-7470-thread-1) [n:127.0.0.1:58179_solr c:readApiTestViolations s:shard1 r:core_node14 x:readApiTestViolations_shard1_replica_n13] o.a.s.c.SolrCore [readApiTestViolations_shard1_replica_n13] CLOSING SolrCore org.apache.solr.core.SolrCore@1ed48fa9 [junit4] 2> 8937983 INFO (coreCloseExecutor-7470-thread-1) [n:127.0.0.1:58179_solr c:readApiTestViolations s:shard1 r:core_node14 x:readApiTestViolations_shard1_replica_n13] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.readApiTestViolations.shard1.replica_n13, tag=517246889 [junit4] 2> 8937983 INFO (coreCloseExecutor-7470-thread-1) [n:127.0.0.1:58179_solr c:readApiTestViolations s:shard1 r:core_node14 x:readApiTestViolations_shard1_replica_n13] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@41002bd2: rootName = solr_58179, domain = solr.core.readApiTestViolations.shard1.replica_n13, service url = null, agent id = null] for registry solr.core.readApiTestViolations.shard1.replica_n13 / com.codahale.metrics.MetricRegistry@3f20a63b [junit4] 2> 8938023 INFO (coreCloseExecutor-7470-thread-1) [n:127.0.0.1:58179_solr c:readApiTestViolations s:shard1 r:core_node14 x:readApiTestViolations_shard1_replica_n13] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.readApiTestViolations.shard1.leader, tag=517246889 [junit4] 2> 8938096 INFO (jetty-closer-3204-thread-1) [ ] o.a.s.c.Overseer Overseer (id=99147357262774278-127.0.0.1:42189_solr-n_0000000000) closing [junit4] 2> 8938097 INFO (OverseerStateUpdate-99147357262774278-127.0.0.1:42189_solr-n_0000000000) [n:127.0.0.1:42189_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42189_solr [junit4] 2> 8938098 WARN (OverseerAutoScalingTriggerThread-99147357262774278-127.0.0.1:42189_solr-n_0000000000) [n:127.0.0.1:42189_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 8938139 INFO (zkCallback-3930-thread-1-processing-n:127.0.0.1:58179_solr) [n:127.0.0.1:58179_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58179_solr [junit4] 2> 8939607 INFO (jetty-closer-3204-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5392b849{/solr,null,UNAVAILABLE} [junit4] 2> 8939617 INFO (jetty-closer-3204-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@34be4487{/solr,null,UNAVAILABLE} [junit4] 2> 8939640 INFO (jetty-closer-3204-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@41a35185{/solr,null,UNAVAILABLE} [junit4] 2> 8939655 ERROR (SUITE-AutoScalingHandlerTest-seed#[E2950CC4C6A7951E]-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> 8939656 INFO (SUITE-AutoScalingHandlerTest-seed#[E2950CC4C6A7951E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51766 51766 [junit4] 2> 8939759 INFO (Thread-3445) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51766 51766 [junit4] 2> 8939760 WARN (Thread-3445) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 197 /solr/aliases.json [junit4] 2> 197 /solr/clusterprops.json [junit4] 2> 3 /solr/security.json [junit4] 2> 3 /solr/configs/conf [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 197 /solr/clusterstate.json [junit4] 2> 39 /solr/collections/readApiTestViolations/state.json [junit4] 2> 5 /solr/collections/COLL1/state.json [junit4] 2> 2 /solr/collections/readApiTestViolations/leader_elect/shard1/election/99147357262774278-core_node11-n_0000000004 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 197 /solr/live_nodes [junit4] 2> 197 /solr/collections [junit4] 2> 2 /solr/autoscaling/events/node_added_trigger1 [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_E2950CC4C6A7951E-001 [junit4] 2> Dec 10, 2017 1:17:44 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=171, maxMBSortInHeap=6.383786849378476, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4e53eadf), locale=el, timezone=Etc/GMT-7 [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=213100160,total=511180800 [junit4] 2> NOTE: All tests run in this JVM: [TestLuceneMatchVersion, NotRequiredUniqueKeyTest, MergeStrategyTest, TestCorePropertiesReload, TestWriterPerf, TestOnReconnectListenerSupport, TestClusterProperties, TestPerFieldSimilarity, DistributedTermsComponentTest, CoreMergeIndexesAdminHandlerTest, SolrMetricReporterTest, OverseerModifyCollectionTest, PingRequestHandlerTest, BufferStoreTest, PropertiesRequestHandlerTest, TestDelegationWithHadoopAuth, TestRTimerTree, SolrRequestParserTest, TestUnifiedSolrHighlighter, TestNumericTokenStream, ChaosMonkeySafeLeaderWithPullReplicasTest, DirectoryFactoryTest, BaseCdcrDistributedZkTest, TestBinaryResponseWriter, TestFieldCacheWithThreads, DocValuesMultiTest, SolrCmdDistributorTest, ChaosMonkeySafeLeaderTest, SuggesterFSTTest, ConcurrentDeleteAndCreateCollectionTest, BlockJoinFacetRandomTest, TestBM25SimilarityFactory, TestRangeQuery, TestFastWriter, DeleteShardTest, TestManagedResource, DocumentAnalysisRequestHandlerTest, SolrSlf4jReporterTest, MetricsConfigTest, DistributedFacetPivotLongTailTest, TestMultiValuedNumericRangeQuery, DebugComponentTest, TestManagedSynonymFilterFactory, TestOmitPositions, TestStressRecovery, SampleTest, AnalyticsQueryTest, OutOfBoxZkACLAndCredentialsProvidersTest, SaslZkACLProviderTest, TestCollationField, TestPushWriter, TestSchemaResource, ConjunctionSolrSpellCheckerTest, TestCoreBackup, BadIndexSchemaTest, ConvertedLegacyTest, TestNonDefinedSimilarityFactory, TestUseDocValuesAsStored, TestConfigSetsAPI, DistributedFacetPivotWhiteBoxTest, SystemLogListenerTest, TestDownShardTolerantSearch, SpellingQueryConverterTest, TestSimpleTextCodec, TestUtilizeNode, MissingSegmentRecoveryTest, SimpleCollectionCreateDeleteTest, TestIntervalFaceting, TestSolr4Spatial2, CloneFieldUpdateProcessorFactoryTest, TestSolrCloudWithDelegationTokens, SOLR749Test, BinaryUpdateRequestHandlerTest, TestScoreJoinQPScore, TestPKIAuthenticationPlugin, TestBulkSchemaAPI, BooleanFieldTest, TestMacros, TestAddFieldRealTimeGet, DistribDocExpirationUpdateProcessorTest, TestImplicitCoreProperties, PolyFieldTest, ZkCLITest, TestFieldCacheSort, HdfsChaosMonkeyNothingIsSafeTest, RemoteQueryErrorTest, ManagedSchemaRoundRobinCloudTest, CachingDirectoryFactoryTest, DistributedExpandComponentTest, TemplateUpdateProcessorTest, DeleteLastCustomShardedReplicaTest, SolrXmlInZkTest, RestartWhileUpdatingTest, SparseHLLTest, TestDefaultStatsCache, LeaderInitiatedRecoveryOnShardRestartTest, SynonymTokenizerTest, CollectionsAPIDistributedZkTest, HdfsRestartWhileUpdatingTest, TestTlogReplica, TestSolrCloudSnapshots, CdcrReplicationDistributedZkTest, TestDynamicFieldResource, TestXIncludeConfig, TestManagedSchema, TestSolr4Spatial, SolrIndexConfigTest, HdfsNNFailoverTest, TestNumericTerms64, TestAtomicUpdateErrorCases, ClassificationUpdateProcessorFactoryTest, OutputWriterTest, OpenCloseCoreStressTest, VMParamsZkACLAndCredentialsProvidersTest, TestReqParamsAPI, OpenExchangeRatesOrgProviderTest, TestSolrQueryParser, TestZkAclsWithHadoopAuth, MoreLikeThisHandlerTest, TestCloudInspectUtil, QueryEqualityTest, TestCursorMarkWithoutUniqueKey, TestRemoteStreaming, BasicDistributedZkTest, TestReplicationHandler, ShardRoutingCustomTest, TestDistributedSearch, TermVectorComponentDistributedTest, TestCoreContainer, TestGroupingSearch, PeerSyncTest, TestFunctionQuery, BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig, SoftAutoCommitTest, PrimitiveFieldTypeTest, TermsComponentTest, TestComponentsName, TestLFUCache, ConfigSetsAPITest, CreateCollectionCleanupTest, CustomCollectionTest, HealthCheckHandlerTest, LeaderElectionContextKeyTest, LeaderFailoverAfterPartitionTest, ReplaceNodeTest, ShardSplitTest, TestPullReplicaErrorHandling, TestShortCircuitedRequests, TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorRandomCloud, AutoScalingHandlerTest] [junit4] Completed [572/752 (7!)] on J1 in 55.13s, 8 tests, 1 failure <<< FAILURES! [...truncated 47902 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org