lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-Linux (32bit/jdk1.8.0_162) - Build # 21982 - Unstable!
Date Wed, 09 May 2018 15:55:26 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21982/
Java: 32bit/jdk1.8.0_162 -client -XX:+UseSerialGC

4 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState

Error Message:
Did not expect the processor to fire on first run! event={   "id":"413531bda5572T6tqw4dc6tb85ecxlk2kt497ed",   "source":"node_added_trigger",   "eventTime":1147147577349490,   "eventType":"NODEADDED",   "properties":{     "eventTimes":[       1147147577349490,       1147147577350956,       1147147577351493,       1147147577351975],     "nodeNames":[       "127.0.0.1:33273_solr",       "127.0.0.1:38901_solr",       "127.0.0.1:42193_solr",       "127.0.0.1:37015_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! event={
  "id":"413531bda5572T6tqw4dc6tb85ecxlk2kt497ed",
  "source":"node_added_trigger",
  "eventTime":1147147577349490,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1147147577349490,
      1147147577350956,
      1147147577351493,
      1147147577351975],
    "nodeNames":[
      "127.0.0.1:33273_solr",
      "127.0.0.1:38901_solr",
      "127.0.0.1:42193_solr",
      "127.0.0.1:37015_solr"]}}
	at __randomizedtesting.SeedInfo.seed([CB3B16007ED089DC:595B29386E9F1CA]: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.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState

Error Message:
Did not expect the processor to fire on first run! event={   "id":"4135897cd404cT6tqw4dc6tb85ecxlk2kt497eh",   "source":"node_added_trigger",   "eventTime":1147171131703372,   "eventType":"NODEADDED",   "properties":{     "eventTimes":[       1147171131703372,       1147171131705927,       1147171131706814,       1147171131707523],     "nodeNames":[       "127.0.0.1:43779_solr",       "127.0.0.1:33213_solr",       "127.0.0.1:37119_solr",       "127.0.0.1:44215_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! event={
  "id":"4135897cd404cT6tqw4dc6tb85ecxlk2kt497eh",
  "source":"node_added_trigger",
  "eventTime":1147171131703372,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1147171131703372,
      1147171131705927,
      1147171131706814,
      1147171131707523],
    "nodeNames":[
      "127.0.0.1:43779_solr",
      "127.0.0.1:33213_solr",
      "127.0.0.1:37119_solr",
      "127.0.0.1:44215_solr"]}}
	at __randomizedtesting.SeedInfo.seed([CB3B16007ED089DC:595B29386E9F1CA]: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.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState

Error Message:
Did not expect the processor to fire on first run! event={   "id":"413586e325796T6tqw4dc6tb85ecxlk2kt497eh",   "source":"node_added_trigger",   "eventTime":1147170433685398,   "eventType":"NODEADDED",   "properties":{     "eventTimes":[       1147170433685398,       1147170433687278,       1147170433688099,       1147170433688745],     "nodeNames":[       "127.0.0.1:38945_solr",       "127.0.0.1:46017_solr",       "127.0.0.1:41123_solr",       "127.0.0.1:35573_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! event={
  "id":"413586e325796T6tqw4dc6tb85ecxlk2kt497eh",
  "source":"node_added_trigger",
  "eventTime":1147170433685398,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1147170433685398,
      1147170433687278,
      1147170433688099,
      1147170433688745],
    "nodeNames":[
      "127.0.0.1:38945_solr",
      "127.0.0.1:46017_solr",
      "127.0.0.1:41123_solr",
      "127.0.0.1:35573_solr"]}}
	at __randomizedtesting.SeedInfo.seed([CB3B16007ED089DC:595B29386E9F1CA]: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.cloud.autoscaling.NodeAddedTriggerTest.testRestoreState

Error Message:
Did not expect the processor to fire on first run! event={   "id":"411561a25d276T6tqw4dc6tb85ecxlk2kt49aor",   "source":"node_added_trigger",   "eventTime":1144961410388598,   "eventType":"NODEADDED",   "properties":{     "eventTimes":[       1144961410388598,       1144961410390891,       1144961410391345,       1144961410391724],     "nodeNames":[       "127.0.0.1:43847_solr",       "127.0.0.1:33567_solr",       "127.0.0.1:41627_solr",       "127.0.0.1:38993_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! event={
  "id":"411561a25d276T6tqw4dc6tb85ecxlk2kt49aor",
  "source":"node_added_trigger",
  "eventTime":1144961410388598,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1144961410388598,
      1144961410390891,
      1144961410391345,
      1144961410391724],
    "nodeNames":[
      "127.0.0.1:43847_solr",
      "127.0.0.1:33567_solr",
      "127.0.0.1:41627_solr",
      "127.0.0.1:38993_solr"]}}
	at __randomizedtesting.SeedInfo.seed([CB3B16007ED089DC:595B29386E9F1CA]: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)




Build Log:
[...truncated 13386 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/init-core-data-001
   [junit4]   2> 991419 WARN  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 991419 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 991421 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 991423 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 991423 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001
   [junit4]   2> 991423 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 991424 INFO  (Thread-2054) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 991424 INFO  (Thread-2054) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 991425 ERROR (Thread-2054) [    ] 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> 991524 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:34729
   [junit4]   2> 991527 INFO  (zkConnectionManagerCallback-4911-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991534 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 991534 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 991534 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 991534 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 991535 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@11d45f3{/solr,null,AVAILABLE}
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@5cccfb{SSL,[ssl, http/1.1]}{127.0.0.1:38993}
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.e.j.s.Server Started @991562ms
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38993}
   [junit4]   2> 991536 ERROR (jetty-launcher-4908-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 991536 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 991537 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:15:53.633Z
   [junit4]   2> 991538 INFO  (zkConnectionManagerCallback-4913-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991539 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 991549 INFO  (jetty-launcher-4908-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 991550 INFO  (zkConnectionManagerCallback-4917-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991552 INFO  (zkConnectionManagerCallback-4919-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991630 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 991630 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38993_solr
   [junit4]   2> 991630 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.Overseer Overseer (id=72132629249196035-127.0.0.1:38993_solr-n_0000000000) starting
   [junit4]   2> 991636 INFO  (zkConnectionManagerCallback-4926-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991638 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 991638 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38993_solr
   [junit4]   2> 991639 INFO  (OverseerStateUpdate-72132629249196035-127.0.0.1:38993_solr-n_0000000000) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 991640 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 991855 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38993.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 991863 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38993.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 991864 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38993.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 991865 INFO  (jetty-launcher-4908-thread-1) [n:127.0.0.1:38993_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node1/.
   [junit4]   2> 991881 INFO  (zkConnectionManagerCallback-4928-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991883 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 0x100443e7f1d0005, likely client has closed socket
   [junit4]   2> 991885 INFO  (zkConnectionManagerCallback-4933-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991886 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 991887 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 991902 INFO  (TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
   [junit4]   2> 991904 INFO  (TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
   [junit4]   2> 991914 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
   [junit4]   2> 991916 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 991918 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 991918 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 991918 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 991919 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@375b2b{/solr,null,AVAILABLE}
   [junit4]   2> 991919 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@11c7494{SSL,[ssl, http/1.1]}{127.0.0.1:43847}
   [junit4]   2> 991919 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server Started @991945ms
   [junit4]   2> 991919 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43847}
   [junit4]   2> 991920 ERROR (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 991920 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 991920 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 991920 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 991920 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 991920 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:15:54.016Z
   [junit4]   2> 991922 INFO  (zkConnectionManagerCallback-4935-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991922 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 991932 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 991933 INFO  (zkConnectionManagerCallback-4939-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991935 INFO  (zkConnectionManagerCallback-4941-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 991941 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 991943 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 991944 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 991944 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43847_solr
   [junit4]   2> 991945 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 991946 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 991946 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 991946 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 992268 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43847.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 992277 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43847.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 992277 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43847.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 992278 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node2/.
   [junit4]   2> 992282 INFO  (zkConnectionManagerCallback-4948-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 992283 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 992285 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [n:127.0.0.1:43847_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 992310 INFO  (TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
   [junit4]   2> 992325 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testTrigger
   [junit4]   2> 992327 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 992329 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 992329 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 992329 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 992329 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1057a1d{/solr,null,AVAILABLE}
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@110bad{SSL,[ssl, http/1.1]}{127.0.0.1:33567}
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server Started @992356ms
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33567}
   [junit4]   2> 992330 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 992330 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 992331 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 992331 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:15:54.427Z
   [junit4]   2> 992332 INFO  (zkConnectionManagerCallback-4950-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 992333 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 992343 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 992345 INFO  (zkConnectionManagerCallback-4954-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 992347 INFO  (zkConnectionManagerCallback-4956-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 992351 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 992353 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 992354 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 992354 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33567_solr
   [junit4]   2> 992355 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 992355 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 992355 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 992355 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 992356 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 992356 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 993031 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33567.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 993039 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33567.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 993040 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33567.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 993041 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node3/.
   [junit4]   2> 993044 INFO  (zkConnectionManagerCallback-4963-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 993046 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 993046 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:33567_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 993078 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 993079 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 993079 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 993079 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 993080 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@18bb6c6{/solr,null,AVAILABLE}
   [junit4]   2> 993080 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@4deefa{SSL,[ssl, http/1.1]}{127.0.0.1:41627}
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server Started @993106ms
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41627}
   [junit4]   2> 993081 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 993081 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:15:55.177Z
   [junit4]   2> 993082 INFO  (zkConnectionManagerCallback-4965-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 993083 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 993103 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 993105 INFO  (zkConnectionManagerCallback-4969-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 993107 INFO  (zkConnectionManagerCallback-4971-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 993112 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 993114 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 993115 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 993115 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41627_solr
   [junit4]   2> 993116 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993116 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993116 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993116 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993116 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993116 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993117 INFO  (zkCallback-4962-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 993117 INFO  (zkCallback-4970-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 994482 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41627.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 994490 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41627.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 994491 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41627.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 994492 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node4/.
   [junit4]   2> 994495 INFO  (zkConnectionManagerCallback-4978-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 994496 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 994496 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:41627_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 996547 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 996547 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 996548 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 996548 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 996548 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@12d96aa{/solr,null,AVAILABLE}
   [junit4]   2> 996548 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1ed5901{SSL,[ssl, http/1.1]}{127.0.0.1:38201}
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server Started @996574ms
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38201}
   [junit4]   2> 996549 ERROR (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 996549 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:15:58.645Z
   [junit4]   2> 996550 INFO  (zkConnectionManagerCallback-4980-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 996551 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 996561 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 996562 INFO  (zkConnectionManagerCallback-4984-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 996564 INFO  (zkConnectionManagerCallback-4986-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 996568 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 996569 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 996571 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 996571 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38201_solr
   [junit4]   2> 996572 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4962-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4970-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996572 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996573 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 996573 INFO  (zkCallback-4985-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 999758 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38201.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 999767 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38201.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 999767 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38201.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 999768 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node5/.
   [junit4]   2> 999772 INFO  (zkConnectionManagerCallback-4993-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 999773 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 999774 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [n:127.0.0.1:38201_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 999822 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1ed5901{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 999823 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14170726
   [junit4]   2> 999823 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 999823 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1833287: rootName = solr_38201, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1c0302
   [junit4]   2> 999830 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 999830 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@181673b: rootName = solr_38201, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 999833 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 999834 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1ecec99: rootName = solr_38201, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 999835 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38201_solr
   [junit4]   2> 999836 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 999836 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4985-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4970-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4962-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999836 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 999837 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 1001337 WARN  (zkCallback-4992-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> 1001338 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@12d96aa{/solr,null,UNAVAILABLE}
   [junit4]   2> 1001338 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1006339 INFO  (TEST-NodeAddedTriggerTest.testTrigger-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testTrigger
   [junit4]   2> 1006374 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
   [junit4]   2> 1006376 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_162-b12
   [junit4]   2> 1006376 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1006376 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1006376 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1006377 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@15e0fed{/solr,null,AVAILABLE}
   [junit4]   2> 1006377 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1e45762{SSL,[ssl, http/1.1]}{127.0.0.1:34923}
   [junit4]   2> 1006377 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.e.j.s.Server Started @1006403ms
   [junit4]   2> 1006377 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34923}
   [junit4]   2> 1006378 ERROR (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1006378 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1006378 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 1006378 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1006378 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1006378 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-05-09T15:16:08.474Z
   [junit4]   2> 1006380 INFO  (zkConnectionManagerCallback-4995-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1006380 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1006401 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34729/solr
   [junit4]   2> 1006402 INFO  (zkConnectionManagerCallback-4999-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1006404 INFO  (zkConnectionManagerCallback-5001-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1006408 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1006409 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1006411 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1006411 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34923_solr
   [junit4]   2> 1006412 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4962-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4970-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4932-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006412 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006413 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1006413 INFO  (zkCallback-5000-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1008703 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34923.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 1008712 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34923.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 1008712 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34923.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@70c7ad
   [junit4]   2> 1008714 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001/tempDir-001/node6/.
   [junit4]   2> 1008717 INFO  (zkConnectionManagerCallback-5008-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1008718 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 1008719 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [n:127.0.0.1:34923_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34729/solr ready
   [junit4]   2> 1008768 INFO  (TEST-NodeAddedTriggerTest.testRestoreState-seed#[CB3B16007ED089DC]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState -Dtests.seed=CB3B16007ED089DC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-BH -Dtests.timezone=EAT -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 2.43s J0 | NodeAddedTriggerTest.testRestoreState <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Did not expect the processor to fire on first run! event={
   [junit4]    >   "id":"411561a25d276T6tqw4dc6tb85ecxlk2kt49aor",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":1144961410388598,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[
   [junit4]    >       1144961410388598,
   [junit4]    >       1144961410390891,
   [junit4]    >       1144961410391345,
   [junit4]    >       1144961410391724],
   [junit4]    >     "nodeNames":[
   [junit4]    >       "127.0.0.1:43847_solr",
   [junit4]    >       "127.0.0.1:33567_solr",
   [junit4]    >       "127.0.0.1:41627_solr",
   [junit4]    >       "127.0.0.1:38993_solr"]}}
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([CB3B16007ED089DC:595B29386E9F1CA]: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> 1008780 INFO  (jetty-closer-4909-thread-3) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@110bad{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1008781 INFO  (jetty-closer-4909-thread-2) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@11c7494{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1008782 INFO  (jetty-closer-4909-thread-1) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@5cccfb{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1008782 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=4752281
   [junit4]   2> 1008783 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=27668049
   [junit4]   2> 1008783 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30673631
   [junit4]   2> 1008783 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1008783 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1008783 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1008784 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f6f1a6: rootName = solr_33567, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1723b59
   [junit4]   2> 1008784 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@190c950: rootName = solr_38993, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@bc014d
   [junit4]   2> 1008784 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@145a5b3: rootName = solr_43847, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1e9f487
   [junit4]   2> 1008784 INFO  (jetty-closer-4909-thread-4) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@4deefa{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1008785 INFO  (jetty-closer-4909-thread-6) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1e45762{SSL,[ssl, http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1008786 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=6561951
   [junit4]   2> 1008786 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1008786 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@912c6d: rootName = solr_41627, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@ea243
   [junit4]   2> 1008787 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16648514
   [junit4]   2> 1008787 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
   [junit4]   2> 1008787 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@39dbd3: rootName = solr_34923, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@ad7b4
   [junit4]   2> 1008796 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1008796 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1008796 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@195aa82: rootName = solr_43847, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 1008796 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@14d9846: rootName = solr_38993, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 1008797 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1008797 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e3aaa6: rootName = solr_33567, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 1008797 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1008797 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@d8e993: rootName = solr_41627, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 1008798 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
   [junit4]   2> 1008798 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e0bdc7: rootName = solr_34923, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1fdb4b
   [junit4]   2> 1008802 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1008802 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@362167: rootName = solr_43847, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@dade00: rootName = solr_38993, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1656a4f: rootName = solr_33567, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5f6d2f: rootName = solr_34923, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 1008803 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@84101a: rootName = solr_41627, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@62dd3
   [junit4]   2> 1008804 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43847_solr
   [junit4]   2> 1008804 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:33567_solr
   [junit4]   2> 1008804 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:38993_solr
   [junit4]   2> 1008805 INFO  (jetty-closer-4909-thread-2) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 1008805 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:41627_solr
   [junit4]   2> 1008805 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 1008805 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008805 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 1008805 INFO  (zkCallback-4970-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008805 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008805 INFO  (zkCallback-4947-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008806 INFO  (jetty-closer-4909-thread-1) [    ] o.a.s.c.Overseer Overseer (id=72132629249196035-127.0.0.1:38993_solr-n_0000000000) closing
   [junit4]   2> 1008806 INFO  (jetty-closer-4909-thread-3) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 1008806 INFO  (zkCallback-4955-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008806 INFO  (OverseerStateUpdate-72132629249196035-127.0.0.1:38993_solr-n_0000000000) [    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:38993_solr
   [junit4]   2> 1008806 WARN  (OverseerAutoScalingTriggerThread-72132629249196035-127.0.0.1:38993_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 1008806 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:34923_solr
   [junit4]   2> 1008806 INFO  (zkCallback-4940-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008806 INFO  (zkCallback-4962-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008806 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008808 INFO  (zkCallback-5007-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008808 INFO  (zkCallback-5000-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (2)
   [junit4]   2> 1008809 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1008809 INFO  (zkCallback-4918-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1008809 INFO  (jetty-closer-4909-thread-4) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 1008809 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1008809 INFO  (zkCallback-5000-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 1008811 INFO  (jetty-closer-4909-thread-6) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 1008811 INFO  (zkCallback-4940-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1008811 INFO  (zkCallback-4977-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1008811 INFO  (zkCallback-4918-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1008811 INFO  (zkCallback-4925-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1008812 INFO  (zkCallback-4970-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1008814 INFO  (zkCallback-5007-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1008814 INFO  (zkCallback-4955-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1008817 INFO  (zkCallback-5000-thread-3) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 1008817 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 0x100443e7f1d0004, likely client has closed socket
   [junit4]   2> 1008819 INFO  (jetty-closer-4909-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@11d45f3{/solr,null,UNAVAILABLE}
   [junit4]   2> 1008819 INFO  (jetty-closer-4909-thread-4) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@18bb6c6{/solr,null,UNAVAILABLE}
   [junit4]   2> 1008819 INFO  (zkCallback-4940-thread-2) [    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43847_solr
   [junit4]   2> 1008819 INFO  (jetty-closer-4909-thread-1) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1008820 INFO  (jetty-closer-4909-thread-4) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1010308 WARN  (zkCallback-4947-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> 1010308 WARN  (zkCallback-4962-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> 1010309 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 0x100443e7f1d0009, likely client has closed socket
   [junit4]   2> 1010309 INFO  (jetty-closer-4909-thread-3) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1057a1d{/solr,null,UNAVAILABLE}
   [junit4]   2> 1010310 INFO  (jetty-closer-4909-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@375b2b{/solr,null,UNAVAILABLE}
   [junit4]   2> 1010310 INFO  (jetty-closer-4909-thread-3) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1010310 INFO  (jetty-closer-4909-thread-2) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1010318 INFO  (jetty-closer-4909-thread-6) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@15e0fed{/solr,null,UNAVAILABLE}
   [junit4]   2> 1010318 INFO  (jetty-closer-4909-thread-6) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1010319 ERROR (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1010319 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34729 34729
   [junit4]   2> 1010418 INFO  (Thread-2054) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34729 34729
   [junit4]   2> 1010419 WARN  (Thread-2054) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/aliases.json
   [junit4]   2> 	6	/solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/clusterstate.json
   [junit4]   2> 	13	/solr/clusterprops.json
   [junit4]   2> 	2	/solr/overseer_elect/election/72132629249196049-127.0.0.1:41627_solr-n_0000000003
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/collections
   [junit4]   2> 	12	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-001
   [junit4]   2> May 09, 2018 3:16:12 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=6, maxDocsPerChunk=888, blockSize=2), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=6, blockSize=2)), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@150722b), locale=ar-BH, timezone=EAT
   [junit4]   2> NOTE: Linux 4.13.0-39-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=130820264,total=323166208
   [junit4]   2> NOTE: All tests run in this JVM: [TestIBSimilarityFactory, TestSQLHandler, ShardRoutingTest, TestPseudoReturnFields, IgnoreLargeDocumentProcessorFactoryTest, AliasIntegrationTest, TestDocSet, SuggestComponentContextFilterQueryTest, AnalyticsQueryTest, ReplicaListTransformerTest, HighlighterConfigTest, DeleteNodeTest, ZkNodePropsTest, TestCoreAdminApis, TestBackupRepositoryFactory, TestClusterStateMutator, TestOmitPositions, BufferStoreTest, SolrGraphiteReporterTest, DistributedFacetSimpleRefinementLongTailTest, SimpleFacetsTest, TestRestManager, TestLuceneMatchVersion, TestRequestStatusCollectionAPI, TestJavabinTupleStreamParser, AddBlockUpdateTest, ConnectionReuseTest, HdfsUnloadDistributedZkTest, TestWordDelimiterFilterFactory, TestCustomStream, TestDelegationWithHadoopAuth, TestWriterPerf, DocumentAnalysisRequestHandlerTes

[...truncated too long message...]

ck-156-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45331 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 0x10044602bde0012, likely client has closed socket
   [junit4]   2> 45332 INFO  (zkCallback-141-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45332 INFO  (zkCallback-134-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45332 INFO  (zkCallback-164-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45332 INFO  (zkCallback-149-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45333 INFO  (zkCallback-112-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
   [junit4]   2> 45333 INFO  (zkCallback-201-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
   [junit4]   2> 45340 INFO  (jetty-closer-103-thread-4) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1a2788c{/solr,null,UNAVAILABLE}
   [junit4]   2> 45340 INFO  (jetty-closer-103-thread-4) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 45340 INFO  (jetty-closer-103-thread-2) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:46017_solr
   [junit4]   2> 45341 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 0x10044602bde000d, likely client has closed socket
   [junit4]   2> 45341 INFO  (jetty-closer-103-thread-6) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43291_solr
   [junit4]   2> 45341 INFO  (jetty-closer-103-thread-3) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@16014c8{/solr,null,UNAVAILABLE}
   [junit4]   2> 45342 INFO  (jetty-closer-103-thread-3) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 45345 INFO  (jetty-closer-103-thread-6) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 45346 INFO  (zkCallback-119-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45346 INFO  (zkCallback-141-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45346 INFO  (zkCallback-134-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45347 INFO  (zkCallback-194-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45348 INFO  (zkCallback-201-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45348 INFO  (jetty-closer-103-thread-2) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 45348 INFO  (jetty-closer-103-thread-1) [    ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:35573_solr
   [junit4]   2> 45350 INFO  (zkCallback-112-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
   [junit4]   2> 45351 INFO  (jetty-closer-103-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
   [junit4]   2> 45351 INFO  (jetty-closer-103-thread-1) [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 45352 INFO  (jetty-closer-103-thread-1) [    ] o.a.s.c.Overseer Overseer (id=72132773881446403-127.0.0.1:35573_solr-n_0000000000) closing
   [junit4]   2> 45352 INFO  (OverseerStateUpdate-72132773881446403-127.0.0.1:35573_solr-n_0000000000) [    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35573_solr
   [junit4]   2> 45352 WARN  (OverseerAutoScalingTriggerThread-72132773881446403-127.0.0.1:35573_solr-n_0000000000) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 45353 INFO  (zkCallback-119-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 45353 INFO  (zkCallback-141-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 45353 INFO  (zkCallback-134-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 45353 INFO  (zkCallback-112-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 45361 INFO  (jetty-closer-103-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1732592{/solr,null,UNAVAILABLE}
   [junit4]   2> 45361 INFO  (jetty-closer-103-thread-2) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 45363 INFO  (jetty-closer-103-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1df7255{/solr,null,UNAVAILABLE}
   [junit4]   2> 45363 INFO  (jetty-closer-103-thread-1) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 46851 WARN  (zkCallback-194-thread-2) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 46852 INFO  (jetty-closer-103-thread-6) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1f4ffae{/solr,null,UNAVAILABLE}
   [junit4]   2> 46852 INFO  (jetty-closer-103-thread-6) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 46853 ERROR (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 46853 INFO  (SUITE-NodeAddedTriggerTest-seed#[CB3B16007ED089DC]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34597 34597
   [junit4]   2> 47710 INFO  (Thread-60) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34597 34597
   [junit4]   2> 47711 WARN  (Thread-60) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/aliases.json
   [junit4]   2> 	6	/solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/clusterstate.json
   [junit4]   2> 	13	/solr/clusterprops.json
   [junit4]   2> 	2	/solr/overseer_elect/election/72132773881446417-127.0.0.1:38945_solr-n_0000000003
   [junit4]   2> 	2	/solr/overseer_elect/election/72132773881446409-127.0.0.1:46017_solr-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	13	/solr/live_nodes
   [junit4]   2> 	13	/solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CB3B16007ED089DC-002
   [junit4]   2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=6, maxDocsPerChunk=888, blockSize=2), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=6, blockSize=2)), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@d2c9ec), locale=ar-BH, timezone=EAT
   [junit4]   2> NOTE: Linux 4.13.0-39-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=7733800,total=41201664
   [junit4]   2> NOTE: All tests run in this JVM: [NodeAddedTriggerTest, NodeAddedTriggerTest]
   [junit4] Completed [5/5 (5!)] on J2 in 22.21s, 4 tests, 1 failure <<< FAILURES!

[...truncated 15 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: There were test failures: 5 suites, 20 tests, 5 failures [seed: CB3B16007ED089DC]

Total time: 49 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   5/5 failed: org.apache.solr.cloud.autoscaling.NodeAddedTriggerTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=7873cf845e1d513026b6836769b7cbd4d237c2aa, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #21981
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2

Mime
View raw message