Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2490/
5 tests failed. FAILED: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState Error Message: Did not expect the processor to fire on first run! event={ "id":"1628dd6b7521e3T6dec3o6ngbyw1p5r9xearbwfw", "source":"node_added_trigger", "eventTime":6237380943356387, "eventType":"NODEADDED", "properties":{ "eventTimes":[6237380943356387], "nodeNames":["127.0.0.1:43309_solr"]}} Stack Trace: java.lang.AssertionError: Did not expect the processor to fire on first run! event={ "id":"1628dd6b7521e3T6dec3o6ngbyw1p5r9xearbwfw", "source":"node_added_trigger", "eventTime":6237380943356387, "eventType":"NODEADDED", "properties":{ "eventTimes":[6237380943356387], "nodeNames":["127.0.0.1:43309_solr"]}} at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:80C1877B17D19DE1]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49) at org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161) at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257) 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.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosData Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:32C601B359005268]:0) at org.apache.lucene.index.IndexWriter$ReaderPool.noDups(IndexWriter.java:867) at org.apache.lucene.index.IndexWriter$ReaderPool.get(IndexWriter.java:857) at org.apache.lucene.index.IndexWriter.numDeletesToMerge(IndexWriter.java:5233) at org.apache.lucene.index.LogMergePolicy.sizeDocs(LogMergePolicy.java:153) at org.apache.lucene.index.LogDocMergePolicy.size(LogDocMergePolicy.java:44) at org.apache.lucene.index.LogMergePolicy.findMerges(LogMergePolicy.java:469) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getMergeCandidatesNames(SegmentsInfoRequestHandler.java:100) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getSegmentsInfo(SegmentsInfoRequestHandler.java:59) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.handleRequestBody(SegmentsInfoRequestHandler.java:48) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2508) at org.apache.solr.util.TestHarness.query(TestHarness.java:337) at org.apache.solr.util.TestHarness.query(TestHarness.java:319) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890) at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosData(SegmentsInfoRequestHandlerTest.java:75) 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.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:B6B1B600978434A4]:0) at org.apache.lucene.index.IndexWriter$ReaderPool.noDups(IndexWriter.java:867) at org.apache.lucene.index.IndexWriter$ReaderPool.get(IndexWriter.java:857) at org.apache.lucene.index.IndexWriter.numDeletesToMerge(IndexWriter.java:5233) at org.apache.lucene.index.LogMergePolicy.sizeDocs(LogMergePolicy.java:153) at org.apache.lucene.index.LogDocMergePolicy.size(LogDocMergePolicy.java:44) at org.apache.lucene.index.LogMergePolicy.findMerges(LogMergePolicy.java:469) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getMergeCandidatesNames(SegmentsInfoRequestHandler.java:100) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getSegmentsInfo(SegmentsInfoRequestHandler.java:59) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.handleRequestBody(SegmentsInfoRequestHandler.java:48) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2508) at org.apache.solr.util.TestHarness.query(TestHarness.java:337) at org.apache.solr.util.TestHarness.query(TestHarness.java:319) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890) at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfosVersion(SegmentsInfoRequestHandlerTest.java:68) 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.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfos Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:238B45725E43DA7]:0) at org.apache.lucene.index.IndexWriter$ReaderPool.noDups(IndexWriter.java:867) at org.apache.lucene.index.IndexWriter$ReaderPool.get(IndexWriter.java:857) at org.apache.lucene.index.IndexWriter.numDeletesToMerge(IndexWriter.java:5233) at org.apache.lucene.index.LogMergePolicy.sizeDocs(LogMergePolicy.java:153) at org.apache.lucene.index.LogDocMergePolicy.size(LogDocMergePolicy.java:44) at org.apache.lucene.index.LogMergePolicy.findMerges(LogMergePolicy.java:469) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getMergeCandidatesNames(SegmentsInfoRequestHandler.java:100) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.getSegmentsInfo(SegmentsInfoRequestHandler.java:59) at org.apache.solr.handler.admin.SegmentsInfoRequestHandler.handleRequestBody(SegmentsInfoRequestHandler.java:48) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2508) at org.apache.solr.util.TestHarness.query(TestHarness.java:337) at org.apache.solr.util.TestHarness.query(TestHarness.java:319) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:890) at org.apache.solr.handler.admin.SegmentsInfoRequestHandlerTest.testSegmentInfos(SegmentsInfoRequestHandlerTest.java:61) 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.IndexSizeTriggerTest.testTrigger Error Message: waitFor not elapsed but produced an event Stack Trace: java.lang.AssertionError: waitFor not elapsed but produced an event at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:2DA4156A762796DA]: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.cloud.autoscaling.IndexSizeTriggerTest.testTrigger(IndexSizeTriggerTest.java:180) 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) Build Log: [...truncated 13556 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest [junit4] 2> 2230753 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/init-core-data-001 [junit4] 2> 2230753 WARN (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 2230754 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2230849 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 2230849 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001 [junit4] 2> 2230849 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2230868 INFO (Thread-2073) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2230869 INFO (Thread-2073) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2230885 ERROR (Thread-2073) [ ] 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> 2230978 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:33016 [junit4] 2> 2231052 INFO (zkConnectionManagerCallback-2388-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2231068 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2231104 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2231104 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2231104 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2231105 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6806ab7f{/solr,null,AVAILABLE} [junit4] 2> 2231105 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@55ef78f6{HTTP/1.1,[http/1.1]}{127.0.0.1:43309} [junit4] 2> 2231105 INFO (jetty-launcher-2385-thread-1) [ ] o.e.j.s.Server Started @2231263ms [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43309} [junit4] 2> 2231106 ERROR (jetty-launcher-2385-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2231106 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:32:57.454Z [junit4] 2> 2231125 INFO (zkConnectionManagerCallback-2390-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2231126 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2231280 INFO (jetty-launcher-2385-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2231351 INFO (zkConnectionManagerCallback-2394-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2231352 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10173c6d66a0002, likely client has closed socket [junit4] 2> 2231388 INFO (zkConnectionManagerCallback-2396-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2232030 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2232031 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43309_solr [junit4] 2> 2232031 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.Overseer Overseer (id=72466366852628483-127.0.0.1:43309_solr-n_0000000000) starting [junit4] 2> 2232213 INFO (zkConnectionManagerCallback-2403-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2232233 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2232322 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43309_solr [junit4] 2> 2232358 INFO (OverseerStateUpdate-72466366852628483-127.0.0.1:43309_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2232525 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2233039 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43309.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2233109 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43309.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2233109 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43309.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2233110 INFO (jetty-launcher-2385-thread-1) [n:127.0.0.1:43309_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node1/. [junit4] 2> 2233324 INFO (zkConnectionManagerCallback-2405-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2233547 INFO (zkConnectionManagerCallback-2410-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2233557 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2233557 INFO (SUITE-NodeAddedTriggerTest-seed#[4E6F23E8EFE8E5F7]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2233657 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRestoreState [junit4] 2> 2233659 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2233832 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2233832 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2233832 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2233832 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26667ce7{/solr,null,AVAILABLE} [junit4] 2> 2233833 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7a62925f{HTTP/1.1,[http/1.1]}{127.0.0.1:38786} [junit4] 2> 2233833 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server Started @2233990ms [junit4] 2> 2233833 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38786} [junit4] 2> 2233833 ERROR (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2233848 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2233848 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2233848 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2233848 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2233848 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:33:00.196Z [junit4] 2> 2233900 INFO (zkConnectionManagerCallback-2412-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2233924 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2234085 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2234177 INFO (zkConnectionManagerCallback-2416-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2234417 INFO (zkConnectionManagerCallback-2418-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2234755 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2234773 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2234775 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2234775 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38786_solr [junit4] 2> 2234882 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2234882 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2234934 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2234972 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2235874 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38786.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2235925 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38786.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2235925 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38786.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2235926 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node2/. [junit4] 2> 2235990 INFO (zkConnectionManagerCallback-2425-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2235996 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2235997 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:38786_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2236220 INFO (TEST-NodeAddedTriggerTest.testRestoreState-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRestoreState [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState -Dtests.seed=4E6F23E8EFE8E5F7 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=lt -Dtests.timezone=Pacific/Fakaofo -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 2.74s J0 | NodeAddedTriggerTest.testRestoreState <<< [junit4] > Throwable #1: java.lang.AssertionError: Did not expect the processor to fire on first run! event={ [junit4] > "id":"1628dd6b7521e3T6dec3o6ngbyw1p5r9xearbwfw", [junit4] > "source":"node_added_trigger", [junit4] > "eventTime":6237380943356387, [junit4] > "eventType":"NODEADDED", [junit4] > "properties":{ [junit4] > "eventTimes":[6237380943356387], [junit4] > "nodeNames":["127.0.0.1:43309_solr"]}} [junit4] > at __randomizedtesting.SeedInfo.seed([4E6F23E8EFE8E5F7:80C1877B17D19DE1]:0) [junit4] > at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.lambda$new$0(NodeAddedTriggerTest.java:49) [junit4] > at org.apache.solr.cloud.autoscaling.NodeAddedTrigger.run(NodeAddedTrigger.java:161) [junit4] > at org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState(NodeAddedTriggerTest.java:257) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2236447 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance [junit4] 2> 2236481 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2236597 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2236597 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2236597 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 2236598 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3267368d{/solr,null,AVAILABLE} [junit4] 2> 2236598 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5f91acac{HTTP/1.1,[http/1.1]}{127.0.0.1:41551} [junit4] 2> 2236598 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server Started @2236756ms [junit4] 2> 2236598 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41551} [junit4] 2> 2236611 ERROR (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2236611 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2236611 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2236611 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2236611 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2236611 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:33:02.959Z [junit4] 2> 2236656 INFO (zkConnectionManagerCallback-2427-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2236664 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2236774 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2236798 INFO (zkConnectionManagerCallback-2431-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2236944 INFO (zkConnectionManagerCallback-2433-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2237014 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2237016 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2237051 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2237051 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41551_solr [junit4] 2> 2237053 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2237217 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2237233 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2237233 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2237233 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2237423 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2238738 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41551.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2238904 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41551.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2238904 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41551.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2238919 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node3/. [junit4] 2> 2238946 INFO (zkConnectionManagerCallback-2440-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2238947 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2238948 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41551_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2239357 INFO (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance [junit4] 2> 2239432 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrigger [junit4] 2> 2239467 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2239604 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2239604 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2239604 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2239605 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@35b11be9{/solr,null,AVAILABLE} [junit4] 2> 2239605 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@582606cb{HTTP/1.1,[http/1.1]}{127.0.0.1:33712} [junit4] 2> 2239605 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server Started @2239763ms [junit4] 2> 2239605 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33712} [junit4] 2> 2239606 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2239606 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2239606 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2239606 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2239606 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2239606 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:33:05.954Z [junit4] 2> 2239620 INFO (zkConnectionManagerCallback-2442-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2239621 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2239712 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2239731 INFO (zkConnectionManagerCallback-2446-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2239766 INFO (zkConnectionManagerCallback-2448-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2239784 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 2239785 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2239844 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2239844 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33712_solr [junit4] 2> 2239846 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2239846 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2239846 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2239846 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2239868 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2240031 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2240042 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2240213 INFO (zkCallback-2447-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 2241434 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33712.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2241557 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33712.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2241557 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33712.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2241559 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node4/. [junit4] 2> 2241654 INFO (zkConnectionManagerCallback-2455-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2241655 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2241656 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:33712_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2241939 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2241939 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2241939 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2241940 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 2241940 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7cc0d9d{/solr,null,AVAILABLE} [junit4] 2> 2241940 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@56e638e2{HTTP/1.1,[http/1.1]}{127.0.0.1:41153} [junit4] 2> 2241940 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server Started @2242098ms [junit4] 2> 2241940 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41153} [junit4] 2> 2241941 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2241941 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2241941 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2241941 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2241941 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2241941 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:33:08.289Z [junit4] 2> 2242019 INFO (zkConnectionManagerCallback-2457-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2242035 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2242199 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2242267 INFO (zkConnectionManagerCallback-2461-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2242332 INFO (zkConnectionManagerCallback-2463-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2242381 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 2242383 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2242398 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2242399 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41153_solr [junit4] 2> 2242400 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242400 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242400 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242400 INFO (zkCallback-2447-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242418 INFO (zkCallback-2395-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242424 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242424 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242424 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242454 INFO (zkCallback-2462-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2242498 INFO (zkCallback-2454-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5) [junit4] 2> 2244392 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41153.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2244430 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41153.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2244430 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41153.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2244444 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node5/. [junit4] 2> 2244463 INFO (zkConnectionManagerCallback-2470-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2244464 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5) [junit4] 2> 2244464 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:41153_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2248790 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2248830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2248830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2248830 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2248831 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@df24acf{/solr,null,AVAILABLE} [junit4] 2> 2248831 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6bc22d1a{HTTP/1.1,[http/1.1]}{127.0.0.1:34280} [junit4] 2> 2248831 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.Server Started @2248989ms [junit4] 2> 2248831 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34280} [junit4] 2> 2248832 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2248832 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2248832 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2248832 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2248832 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2248832 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-16T17:33:15.180Z [junit4] 2> 2248866 INFO (zkConnectionManagerCallback-2472-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2248867 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2248920 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33016/solr [junit4] 2> 2248921 INFO (zkConnectionManagerCallback-2476-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2248943 INFO (zkConnectionManagerCallback-2478-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2248961 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5) [junit4] 2> 2248963 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2248989 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2248989 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34280_solr [junit4] 2> 2248990 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248990 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248990 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248991 INFO (zkCallback-2462-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248991 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248991 INFO (zkCallback-2454-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2248991 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2249005 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2249006 INFO (zkCallback-2447-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2249006 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2249044 INFO (zkCallback-2477-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2249089 INFO (zkCallback-2469-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6) [junit4] 2> 2251198 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34280.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2251269 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34280.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2251270 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34280.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@565486f9 [junit4] 2> 2251271 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_4E6F23E8EFE8E5F7-001/tempDir-001/node6/. [junit4] 2> 2251341 INFO (zkConnectionManagerCallback-2485-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2251342 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (6) [junit4] 2> 2251343 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [n:127.0.0.1:34280_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33016/solr ready [junit4] 2> 2251786 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6bc22d1a{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2251786 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1809791243 [junit4] 2> 2251787 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2251787 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48de47fc: rootName = solr_34280, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@65aa3827 [junit4] 2> 2251842 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2251842 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a56de18: rootName = solr_34280, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2251859 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2251859 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16e14381: rootName = solr_34280, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2251860 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:34280_solr [junit4] 2> 2251935 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251935 INFO (zkCallback-2409-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251936 INFO (zkCallback-2447-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251936 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251937 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2251970 WARN (zkCallback-2484-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 2251970 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251970 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251971 INFO (zkCallback-2477-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251971 INFO (zkCallback-2462-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251971 INFO (zkCallback-2454-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251971 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251972 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@df24acf{/solr,null,UNAVAILABLE} [junit4] 2> 2251972 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 2251973 INFO (zkCallback-2469-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2251973 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 2257005 INFO (TEST-NodeAddedTriggerTest.testTrigger-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrigger [junit4] 2> 2257231 INFO (TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle [junit4] 2> 2257249 INFO (TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[4E6F23E8EFE8E5F7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle [junit4] 2> 2257251 INFO (jetty-closer-2386-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@582606cb{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2257252 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1772722819 [junit4] 2> 2257252 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2257252 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@154312e: rootName = solr_33712, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@57ca957c [junit4] 2> 2257252 INFO (jetty-closer-2386-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5f91acac{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1091996215 [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7a62925f{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@366c62a8: rootName = solr_41551, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@91266fc [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1068335977 [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2257282 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4163918a: rootName = solr_38786, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@49a83e14 [junit4] 2> 2257283 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2257283 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@200d7390: rootName = solr_33712, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2257405 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2257405 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@758d43eb: rootName = solr_33712, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2257419 INFO (jetty-closer-2386-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@55ef78f6{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2257419 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2104561528 [junit4] 2> 2257420 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:33712_solr [junit4] 2> 2257421 INFO (jetty-closer-2386-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2257421 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257421 INFO (zkCallback-2454-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257421 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257421 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257421 INFO (zkCallback-2462-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257422 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2257422 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4d110afe: rootName = solr_38786, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2257422 INFO (zkCallback-2447-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257422 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2257460 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2257460 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@53b7c09e: rootName = solr_43309, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5bbfb084 [junit4] 2> 2257461 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@62b4fb0a: rootName = solr_41551, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2257460 INFO (jetty-closer-2386-thread-5) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@56e638e2{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2257485 INFO (zkCallback-2469-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257485 INFO (zkCallback-2395-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257485 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257485 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4) [junit4] 2> 2257485 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1011971656 [junit4] 2> 2257485 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2257485 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7c2f80fa: rootName = solr_41153, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6214adb [junit4] 2> 2257488 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2257488 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@315e73a0: rootName = solr_41551, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2257490 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2257490 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@324987cf: rootName = solr_38786, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2257502 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2257502 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@77d9006a: rootName = solr_43309, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2257510 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2257510 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@35fe4b4c: rootName = solr_41153, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4837f811 [junit4] 2> 2257522 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2257522 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@55dadcb3: rootName = solr_43309, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2257526 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43309_solr [junit4] 2> 2257527 INFO (zkCallback-2395-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257527 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2257527 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2257527 INFO (jetty-closer-2386-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72466366852628483-127.0.0.1:43309_solr-n_0000000000) closing [junit4] 2> 2257528 INFO (OverseerStateUpdate-72466366852628483-127.0.0.1:43309_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43309_solr [junit4] 2> 2257528 WARN (OverseerAutoScalingTriggerThread-72466366852628483-127.0.0.1:43309_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 2257668 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2257668 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7bd2c23e: rootName = solr_41153, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3e7ca34c [junit4] 2> 2257669 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257679 INFO (jetty-closer-2386-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@35b11be9{/solr,null,UNAVAILABLE} [junit4] 2> 2257680 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257680 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257680 INFO (jetty-closer-2386-thread-4) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 2257682 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257691 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41551_solr [junit4] 2> 2257692 INFO (jetty-closer-2386-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 2257720 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38786_solr [junit4] 2> 2257720 INFO (zkCallback-2469-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257721 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 2257721 INFO (zkCallback-2439-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257722 INFO (zkCallback-2424-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257722 INFO (zkCallback-2462-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2) [junit4] 2> 2257740 INFO (jetty-closer-2386-thread-5) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41153_solr [junit4] 2> 2257740 INFO (zkCallback-2469-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257748 INFO (zkCallback-2417-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257748 INFO (zkCallback-2395-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257748 INFO (zkCallback-2402-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 2257749 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10173c6d66a000e, likely client has closed socket [junit4] 2> 2257749 INFO (zkCallback-2432-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1) [junit4] 2> 2257749 INFO (jetty-closer-2386-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [...truncated too long message...] ngs.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/null869368936 [copy] Copying 40 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/null869368936 [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/null869368936 resolve-example: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: resolve-server: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1052677900 [copy] Copying 246 files to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1052677900 [delete] Deleting directory /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/null1052677900 check-working-copy: [ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working [ivy:cachepath] confs: [default] [ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public [ivy:cachepath] found com.jcraft#jsch;0.1.53 in public [ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public [ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public [ivy:cachepath] found commons-codec#commons-codec;1.6 in public [ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public [ivy:cachepath] :: resolution report :: resolve 29ms :: artifacts dl 1ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 8 | 0 | 0 | 0 || 8 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". [wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation [wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. [wc-checker] Checking working copy status... -jenkins-base: BUILD SUCCESSFUL Total time: 224 minutes 30 seconds Archiving artifacts WARN: No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error? WARN: java.lang.InterruptedException: no matches found within 10000 Recording test results Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures)
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org