Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21877/
Java: 32bit/jdk1.8.0_162 -client -XX:+UseG1GC

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":"68cbc1dad9432Tf1iz00uyuo15x1mcnywcvvbag",   
"source":"node_added_trigger",   "eventTime":1843589439919154,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[       
1843589439919154,       1843589439920845,       1843589439921546,       
1843589439922026],     "nodeNames":[       "127.0.0.1:41761_solr",       
"127.0.0.1:42365_solr",       "127.0.0.1:33213_solr",       
"127.0.0.1:42563_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! 
event={
  "id":"68cbc1dad9432Tf1iz00uyuo15x1mcnywcvvbag",
  "source":"node_added_trigger",
  "eventTime":1843589439919154,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1843589439919154,
      1843589439920845,
      1843589439921546,
      1843589439922026],
    "nodeNames":[
      "127.0.0.1:41761_solr",
      "127.0.0.1:42365_solr",
      "127.0.0.1:33213_solr",
      "127.0.0.1:42563_solr"]}}
        at 
__randomizedtesting.SeedInfo.seed([CA063B9166DD5B70:4A89F029EE42366]: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":"68cc188d5819aTf1iz00uyuo15x1mcnywcvvbak",   
"source":"node_added_trigger",   "eventTime":1843612712534426,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[       
1843612712534426,       1843612712536780,       1843612712537746,       
1843612712538421],     "nodeNames":[       "127.0.0.1:40571_solr",       
"127.0.0.1:40377_solr",       "127.0.0.1:33281_solr",       
"127.0.0.1:43411_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! 
event={
  "id":"68cc188d5819aTf1iz00uyuo15x1mcnywcvvbak",
  "source":"node_added_trigger",
  "eventTime":1843612712534426,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1843612712534426,
      1843612712536780,
      1843612712537746,
      1843612712538421],
    "nodeNames":[
      "127.0.0.1:40571_solr",
      "127.0.0.1:40377_solr",
      "127.0.0.1:33281_solr",
      "127.0.0.1:43411_solr"]}}
        at 
__randomizedtesting.SeedInfo.seed([CA063B9166DD5B70:4A89F029EE42366]: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":"68cc1adbc8dcbTf1iz00uyuo15x1mcnywcvvbak",   
"source":"node_added_trigger",   "eventTime":1843613331656139,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[       
1843613331656139,       1843613331658369,       1843613331659165,       
1843613331659780],     "nodeNames":[       "127.0.0.1:41027_solr",       
"127.0.0.1:40903_solr",       "127.0.0.1:44029_solr",       
"127.0.0.1:41971_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! 
event={
  "id":"68cc1adbc8dcbTf1iz00uyuo15x1mcnywcvvbak",
  "source":"node_added_trigger",
  "eventTime":1843613331656139,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1843613331656139,
      1843613331658369,
      1843613331659165,
      1843613331659780],
    "nodeNames":[
      "127.0.0.1:41027_solr",
      "127.0.0.1:40903_solr",
      "127.0.0.1:44029_solr",
      "127.0.0.1:41971_solr"]}}
        at 
__randomizedtesting.SeedInfo.seed([CA063B9166DD5B70:4A89F029EE42366]: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":"68aaf47352604Tf1iz00uyuo15x1mcnywcvvhky",   
"source":"node_added_trigger",   "eventTime":1841335278839300,   
"eventType":"NODEADDED",   "properties":{     "eventTimes":[       
1841335278839300,       1841335278842620,       1841335278843301,       
1841335278843780],     "nodeNames":[       "127.0.0.1:44361_solr",       
"127.0.0.1:44017_solr",       "127.0.0.1:43263_solr",       
"127.0.0.1:42463_solr"]}}

Stack Trace:
java.lang.AssertionError: Did not expect the processor to fire on first run! 
event={
  "id":"68aaf47352604Tf1iz00uyuo15x1mcnywcvvhky",
  "source":"node_added_trigger",
  "eventTime":1841335278839300,
  "eventType":"NODEADDED",
  "properties":{
    "eventTimes":[
      1841335278839300,
      1841335278842620,
      1841335278843301,
      1841335278843780],
    "nodeNames":[
      "127.0.0.1:44361_solr",
      "127.0.0.1:44017_solr",
      "127.0.0.1:43263_solr",
      "127.0.0.1:42463_solr"]}}
        at 
__randomizedtesting.SeedInfo.seed([CA063B9166DD5B70:4A89F029EE42366]: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 13277 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_CA063B9166DD5B70-001/init-core-data-001
   [junit4]   2> 886957 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 886958 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 886958 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 886959 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-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_CA063B9166DD5B70-001/tempDir-001
   [junit4]   2> 886959 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 886959 INFO  (Thread-2016) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 886959 INFO  (Thread-2016) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 886967 ERROR (Thread-2016) [    ] 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> 887059 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:44837
   [junit4]   2> 887062 INFO  (zkConnectionManagerCallback-1941-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887068 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 887078 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 887078 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 887078 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 887080 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@984eb{/solr,null,AVAILABLE}
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@9cb295{SSL,[ssl, 
http/1.1]}{127.0.0.1:42463}
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.e.j.s.Server Started @887110ms
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42463}
   [junit4]   2> 887083 ERROR (jetty-launcher-1938-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 887083 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:14:55.130Z
   [junit4]   2> 887098 INFO  (zkConnectionManagerCallback-1943-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887099 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 887112 INFO  (jetty-launcher-1938-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 887114 INFO  (zkConnectionManagerCallback-1947-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887122 INFO  (zkConnectionManagerCallback-1949-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887215 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 887216 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:42463_solr
   [junit4]   2> 887218 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.c.Overseer Overseer 
(id=72178266816708611-127.0.0.1:42463_solr-n_0000000000) starting
   [junit4]   2> 887224 INFO  (zkConnectionManagerCallback-1956-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887226 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 887227 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42463_solr
   [junit4]   2> 887229 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 887230 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 887947 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42463.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 887957 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42463.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 887958 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42463.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 887959 INFO  (jetty-launcher-1938-thread-1) 
[n:127.0.0.1:42463_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_CA063B9166DD5B70-001/tempDir-001/node1/.
   [junit4]   2> 887988 INFO  (zkConnectionManagerCallback-1958-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887991 INFO  (zkConnectionManagerCallback-1963-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 887992 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 887993 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44837/solr ready
   [junit4]   2> 888009 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testListenerAcceptance
   [junit4]   2> 888037 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 888038 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 888039 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 888039 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 888039 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@ea298b{/solr,null,AVAILABLE}
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.AbstractConnector Started ServerConnector@140efda{SSL,[ssl, 
http/1.1]}{127.0.0.1:43263}
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.e.j.s.Server Started @888067ms
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43263}
   [junit4]   2> 888040 ERROR 
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port 
null
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 888040 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:14:56.087Z
   [junit4]   2> 888042 INFO  (zkConnectionManagerCallback-1965-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 888043 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 888059 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 888061 INFO  (zkConnectionManagerCallback-1969-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 888063 INFO  (zkConnectionManagerCallback-1971-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 888069 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 888070 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 888072 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 888072 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43263_solr
   [junit4]   2> 888073 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 888073 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 888074 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 888074 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 890283 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43263.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 890295 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43263.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 890295 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43263.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 890297 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_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_CA063B9166DD5B70-001/tempDir-001/node2/.
   [junit4]   2> 890304 INFO  (zkConnectionManagerCallback-1978-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 890305 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 890306 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:43263_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 890338 INFO  
(TEST-NodeAddedTriggerTest.testListenerAcceptance-seed#[CA063B9166DD5B70]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testListenerAcceptance
   [junit4]   2> 890356 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testTrigger
   [junit4]   2> 890359 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 890360 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 890360 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 890360 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 890360 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@67b42b{/solr,null,AVAILABLE}
   [junit4]   2> 890360 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@167ffc7{SSL,[ssl, 
http/1.1]}{127.0.0.1:44361}
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server Started @890388ms
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44361}
   [junit4]   2> 890361 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 890361 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:14:58.408Z
   [junit4]   2> 890362 INFO  (zkConnectionManagerCallback-1980-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 890363 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 890371 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 890373 INFO  (zkConnectionManagerCallback-1984-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 890375 INFO  (zkConnectionManagerCallback-1986-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 890380 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 890382 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 890384 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 890384 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44361_solr
   [junit4]   2> 890384 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 890385 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 890385 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 890385 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 890385 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 890385 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 891487 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44361.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891497 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44361.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891497 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44361.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891498 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_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_CA063B9166DD5B70-001/tempDir-001/node3/.
   [junit4]   2> 891501 INFO  (zkConnectionManagerCallback-1993-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 891502 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 891503 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44361_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 891536 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 891537 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 891537 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 891537 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 891537 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1a610c9{/solr,null,AVAILABLE}
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@16ba393{SSL,[ssl, 
http/1.1]}{127.0.0.1:44017}
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server Started @891565ms
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44017}
   [junit4]   2> 891538 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 891538 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:14:59.585Z
   [junit4]   2> 891540 INFO  (zkConnectionManagerCallback-1995-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 891540 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 891549 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 891549 INFO  (zkConnectionManagerCallback-1999-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 891551 INFO  (zkConnectionManagerCallback-2001-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 891557 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 891558 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 891560 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 891560 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44017_solr
   [junit4]   2> 891561 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891561 INFO  (zkCallback-1992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891562 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 891943 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44017.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891952 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44017.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891952 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44017.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 891953 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_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_CA063B9166DD5B70-001/tempDir-001/node4/.
   [junit4]   2> 891956 INFO  (zkConnectionManagerCallback-2008-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 891957 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 891958 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:44017_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 896019 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 896022 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 896022 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 896022 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 896023 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@11d3a4a{/solr,null,AVAILABLE}
   [junit4]   2> 896024 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@197c409{SSL,[ssl, 
http/1.1]}{127.0.0.1:37349}
   [junit4]   2> 896024 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server Started @896052ms
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37349}
   [junit4]   2> 896025 ERROR 
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 896025 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:15:04.072Z
   [junit4]   2> 896030 INFO  (zkConnectionManagerCallback-2010-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 896031 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 896041 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 896043 INFO  (zkConnectionManagerCallback-2014-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 896046 INFO  (zkConnectionManagerCallback-2016-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 896052 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 896053 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 896055 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 896055 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37349_solr
   [junit4]   2> 896056 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896057 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896063 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896064 INFO  (zkCallback-2015-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 896582 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37349.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 896593 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37349.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 896593 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37349.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 896595 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_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_CA063B9166DD5B70-001/tempDir-001/node5/.
   [junit4]   2> 896599 INFO  (zkConnectionManagerCallback-2023-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 896600 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 896601 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:37349_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 896658 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@197c409{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 896659 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=3248191
   [junit4]   2> 896659 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 896659 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b6f86d: rootName = 
solr_37349, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1297277
   [junit4]   2> 896667 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 896667 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1c7816b: rootName = 
solr_37349, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 896671 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 896671 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7b314a: rootName = 
solr_37349, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 896672 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37349_solr
   [junit4]   2> 896673 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896673 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896673 INFO  (zkCallback-1992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896673 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896673 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896673 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 896674 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896674 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896674 INFO  (zkCallback-2015-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896674 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896679 INFO  (zkCallback-2022-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896679 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 896680 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@11d3a4a{/solr,null,UNAVAILABLE}
   [junit4]   2> 896680 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 901682 INFO  
(TEST-NodeAddedTriggerTest.testTrigger-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testTrigger
   [junit4]   2> 901722 INFO  
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testActionLifecycle
   [junit4]   2> 901724 INFO  
(TEST-NodeAddedTriggerTest.testActionLifecycle-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testActionLifecycle
   [junit4]   2> 901761 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRestoreState
   [junit4]   2> 901763 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z, 
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 901764 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 901764 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 901764 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 901764 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1e70706{/solr,null,AVAILABLE}
   [junit4]   2> 901765 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@170e928{SSL,[ssl, 
http/1.1]}{127.0.0.1:38171}
   [junit4]   2> 901765 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.e.j.s.Server Started @901792ms
   [junit4]   2> 901765 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38171}
   [junit4]   2> 901766 ERROR 
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 901766 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 901766 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 901766 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 901766 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 901766 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-04-21T15:15:09.813Z
   [junit4]   2> 901770 INFO  (zkConnectionManagerCallback-2025-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 901771 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 901780 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44837/solr
   [junit4]   2> 901781 INFO  (zkConnectionManagerCallback-2029-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 901783 INFO  (zkConnectionManagerCallback-2031-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 901788 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 901789 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 901791 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 901791 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38171_solr
   [junit4]   2> 901792 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901792 INFO  (zkCallback-1962-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901792 INFO  (zkCallback-1992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901792 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 901793 INFO  (zkCallback-2030-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 903774 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38171.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 903784 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38171.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 903784 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38171.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@ed2279
   [junit4]   2> 903787 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_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_CA063B9166DD5B70-001/tempDir-001/node6/.
   [junit4]   2> 903790 INFO  (zkConnectionManagerCallback-2038-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 903792 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 903793 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) 
[n:127.0.0.1:38171_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:44837/solr ready
   [junit4]   2> 903856 INFO  
(TEST-NodeAddedTriggerTest.testRestoreState-seed#[CA063B9166DD5B70]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRestoreState
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=NodeAddedTriggerTest -Dtests.method=testRestoreState 
-Dtests.seed=CA063B9166DD5B70 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=sq-AL -Dtests.timezone=America/Maceio -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 2.13s J0 | NodeAddedTriggerTest.testRestoreState <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Did not expect the 
processor to fire on first run! event={
   [junit4]    >   "id":"68aaf47352604Tf1iz00uyuo15x1mcnywcvvhky",
   [junit4]    >   "source":"node_added_trigger",
   [junit4]    >   "eventTime":1841335278839300,
   [junit4]    >   "eventType":"NODEADDED",
   [junit4]    >   "properties":{
   [junit4]    >     "eventTimes":[
   [junit4]    >       1841335278839300,
   [junit4]    >       1841335278842620,
   [junit4]    >       1841335278843301,
   [junit4]    >       1841335278843780],
   [junit4]    >     "nodeNames":[
   [junit4]    >       "127.0.0.1:44361_solr",
   [junit4]    >       "127.0.0.1:44017_solr",
   [junit4]    >       "127.0.0.1:43263_solr",
   [junit4]    >       "127.0.0.1:42463_solr"]}}
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([CA063B9166DD5B70:4A89F029EE42366]: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> 903861 INFO  (jetty-closer-1939-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@140efda{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 903861 INFO  (jetty-closer-1939-thread-3) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@167ffc7{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 903861 INFO  (jetty-closer-1939-thread-4) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@16ba393{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 903861 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=3348222
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=28825748
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@19f99f: rootName = 
solr_43263, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@963402
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=8606184
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1010d61: rootName = 
solr_44361, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@780fc1
   [junit4]   2> 903862 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1eb7537: rootName = 
solr_44017, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1fdd5d6
   [junit4]   2> 903866 INFO  (jetty-closer-1939-thread-5) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@170e928{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 903868 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=10172389
   [junit4]   2> 903868 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 903868 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a58c24: rootName = 
solr_38171, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@13dab37
   [junit4]   2> 903869 INFO  (jetty-closer-1939-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@9cb295{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 903869 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=4389706
   [junit4]   2> 903870 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 903870 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@141770b: rootName = 
solr_42463, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@c8aada
   [junit4]   2> 903871 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 903871 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@c67bf1: rootName = 
solr_44361, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 903874 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 903874 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1c71312: rootName = 
solr_44017, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 903877 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 903877 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1316: rootName = solr_44361, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44361_solr
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f47d07: rootName = 
solr_38171, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@ff3e6d: rootName = 
solr_44017, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 903879 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@12d77d8: rootName = 
solr_42463, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 903880 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903880 INFO  (zkCallback-1992-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903880 INFO  (jetty-closer-1939-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 903880 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903881 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 903881 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@e22573: rootName = 
solr_43263, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@10ef9af
   [junit4]   2> 903885 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 903885 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@af7f1a: rootName = 
solr_38171, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 903885 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 903885 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7bcae0: rootName = 
solr_42463, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 903887 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 903887 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@c8d1b0: rootName = 
solr_43263, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@16720cb
   [junit4]   2> 903894 INFO  (zkCallback-1985-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903894 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 INFO  (zkCallback-2030-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 INFO  (zkCallback-2037-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
   [junit4]   2> 903895 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 
0x1006dc0521d000e, likely client has closed socket
   [junit4]   2> 903897 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44017_solr
   [junit4]   2> 903897 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43263_solr
   [junit4]   2> 903897 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38171_solr
   [junit4]   2> 903898 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42463_solr
   [junit4]   2> 903899 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 903899 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 903899 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (jetty-closer-1939-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 903899 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (zkCallback-1970-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (zkCallback-2030-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (zkCallback-1948-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 903899 INFO  (jetty-closer-1939-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 903900 INFO  (jetty-closer-1939-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 903900 INFO  (zkCallback-1955-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903900 INFO  (zkCallback-2007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903901 INFO  (zkCallback-1977-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903903 INFO  (jetty-closer-1939-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72178266816708611-127.0.0.1:42463_solr-n_0000000000) closing
   [junit4]   2> 903908 INFO  (zkCallback-1948-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903908 INFO  (zkCallback-2030-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903908 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 
0x1006dc0521d000a, likely client has closed socket
   [junit4]   2> 903908 INFO  (zkCallback-2000-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (0)
   [junit4]   2> 903908 INFO  (zkCallback-1970-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 903908 INFO  (jetty-closer-1939-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@67b42b{/solr,null,UNAVAILABLE}
   [junit4]   2> 903908 INFO  (zkCallback-2037-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (0)
   [junit4]   2> 903909 INFO  (jetty-closer-1939-thread-3) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 903909 INFO  
(OverseerStateUpdate-72178266816708611-127.0.0.1:42463_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42463_solr
   [junit4]   2> 903909 WARN  
(OverseerAutoScalingTriggerThread-72178266816708611-127.0.0.1:42463_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 903911 INFO  (jetty-closer-1939-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@ea298b{/solr,null,UNAVAILABLE}
   [junit4]   2> 903914 INFO  (jetty-closer-1939-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 903916 INFO  (jetty-closer-1939-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@984eb{/solr,null,UNAVAILABLE}
   [junit4]   2> 903916 INFO  (jetty-closer-1939-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 905411 INFO  (jetty-closer-1939-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1a610c9{/solr,null,UNAVAILABLE}
   [junit4]   2> 905412 INFO  (jetty-closer-1939-thread-4) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 905415 INFO  (jetty-closer-1939-thread-5) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1e70706{/solr,null,UNAVAILABLE}
   [junit4]   2> 905415 INFO  (jetty-closer-1939-thread-5) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 905416 ERROR 
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-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> 905416 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:44837 44837
   [junit4]   2> 905609 INFO  (Thread-2016) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:44837 44837
   [junit4]   2> 905610 WARN  (Thread-2016) [    ] 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/72178266816708625-127.0.0.1:44017_solr-n_0000000003
   [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/J0/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CA063B9166DD5B70-001
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3906, maxDocsPerChunk=732, blockSize=806), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3906, blockSize=806)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@16eeeb3),
 locale=sq-AL, timezone=America/Maceio
   [junit4]   2> NOTE: Linux 4.13.0-37-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=244208344,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestOmitPositions, 
DebugComponentTest, TestSolrCloudSnapshots, RAMDirectoryFactoryTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestFieldSortValues, 
BlobRepositoryCloudTest, CurrencyFieldTypeTest, TestSolrDeletionPolicy1, 
CreateRoutedAliasTest, TimeRoutedAliasUpdateProcessorTest, 
SolrCloudExampleTest, TestIBSimilarityFactory, TestSimpleTextCodec, 
TestFastOutputStream, TestBackupRepositoryFactory, ShardRoutingTest, 
SimpleFacetsTest, DeleteStatusTest, SpellingQueryConverterTest, 
TestPrepRecovery, TestCloudConsistency, TestRemoteStreaming, HdfsSyncSliceTest, 
ExternalFileFieldSortTest, TestMergePolicyConfig, TestNumericTokenStream, 
FullSolrCloudDistribCmdsTest, HighlighterConfigTest, SolrSlf4jReporterTest, 
TestConfigSetProperties, TestReplicationHandlerBackup, AnalyticsQueryTest, 
DistributedFacetPivotLongTailTest, TestNoOpRegenerator, BasicDistributedZkTest, 
CdcrBidirectionalTest, TestRestManager, TestUtilizeNode, BitVectorTest, 
RestartWhileUpdatingTest, SchemaApiFailureTest, TestScoreJoinQPScore, 
MoveReplicaHDFSTest, TestComponentsName, TestUnifiedSolrHighlighter, 
CoreAdminOperationTest, TestGroupingSearch, SolrRequestParserTest, 
BufferStoreTest, TestCrossCoreJoin, TestPseudoReturnFields, 
TestUseDocValuesAsStored, TestInPlaceUpdatesDistrib, 
TestDelegationWithHadoopAuth, V2StandaloneTest, SortSpecParsingTest, 
SpellCheckCollatorTest, TestJsonFacetsWithNestedObjects, TestSolrQueryParser, 
TestStressCloudBlindAtomicUpdates, CleanupOldIndexTest, 
BinaryUpdateRequestHandlerTest, ConnectionReuseTest, TestSortByMinMaxFunction, 
TestWordDelimiterFilterFactory, TestZkAclsWithHadoopAuth, DeleteNodeTest, 
TestLMDirichletSimilarityFactory, TestExportWriter, TestFieldCacheVsDocValues, 
TestHashPartitioner, VersionInfoTest, TestBlendedInfixSuggestions, 
ZkNodePropsTest, HdfsAutoAddReplicasIntegrationTest, 
DistributedFacetPivotWhiteBoxTest, TestComplexPhraseLeadingWildcard, 
BlockJoinFacetRandomTest, SolrPlugin

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

1)
   [junit4]   2> 51419 INFO  (zkCallback-201-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 51419 INFO  (zkCallback-164-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (1)
   [junit4]   2> 51420 INFO  (zkCallback-149-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 51421 INFO  (jetty-closer-103-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@a1ce1e{/solr,null,UNAVAILABLE}
   [junit4]   2> 51421 INFO  (zkCallback-112-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 51421 INFO  (jetty-closer-103-thread-3) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 51421 INFO  (zkCallback-134-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 51421 INFO  (zkCallback-194-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 51422 INFO  (jetty-closer-103-thread-6) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45345_solr
   [junit4]   2> 51424 INFO  (jetty-closer-103-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1470ba{/solr,null,UNAVAILABLE}
   [junit4]   2> 51424 INFO  (zkCallback-112-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 51425 INFO  (zkCallback-194-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 51425 INFO  (jetty-closer-103-thread-6) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 51424 INFO  (zkCallback-201-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 51424 INFO  (jetty-closer-103-thread-2) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 51428 INFO  (jetty-closer-103-thread-6) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@26ff1b{/solr,null,UNAVAILABLE}
   [junit4]   2> 51428 INFO  (jetty-closer-103-thread-6) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 52919 WARN  (zkCallback-119-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> 52921 INFO  (jetty-closer-103-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@ddc5e3{/solr,null,UNAVAILABLE}
   [junit4]   2> 52921 INFO  (jetty-closer-103-thread-1) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 52923 WARN  (zkCallback-164-thread-1) [    ] 
o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:44029_solr
   [junit4]   2> org.apache.zookeeper.KeeperException$SessionExpiredException: 
KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:44029_solr
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:130) 
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
   [junit4]   2>        at 
org.apache.zookeeper.KeeperException.create(KeeperException.java:54) 
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
   [junit4]   2>        at 
org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:786) 
~[zookeeper-3.4.11.jar:3.4.11-37e277162d567b55a07d1755f0b31c32e93c01a0]
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:365)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:365) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:885)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$3(ZkStateReader.java:791)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
 ~[?:1.8.0_162]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:790)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader.access$1400(ZkStateReader.java:73) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1283)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1278)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$1(SolrZkClient.java:269)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
~[?:1.8.0_162]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_162]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:192)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_162]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_162]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_162]
   [junit4]   2> 52931 INFO  (jetty-closer-103-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1138b15{/solr,null,UNAVAILABLE}
   [junit4]   2> 52931 INFO  (jetty-closer-103-thread-4) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 52931 ERROR 
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-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> 52931 INFO  
(SUITE-NodeAddedTriggerTest-seed#[CA063B9166DD5B70]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:38039 38039
   [junit4]   2> 55245 INFO  (Thread-59) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:38039 38039
   [junit4]   2> 55246 WARN  (Thread-59) [    ] 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/72178415789342723-127.0.0.1:41027_solr-n_0000000000
   [junit4]   2>        2       
/solr/overseer_elect/election/72178415789342737-127.0.0.1:44029_solr-n_0000000003
   [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/J1/temp/solr.cloud.autoscaling.NodeAddedTriggerTest_CA063B9166DD5B70-002
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3906, maxDocsPerChunk=732, blockSize=806), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3906, blockSize=806)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@35b649),
 locale=sq-AL, timezone=America/Maceio
   [junit4]   2> NOTE: Linux 4.13.0-37-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=38861704,total=94371840
   [junit4]   2> NOTE: All tests run in this JVM: [NodeAddedTriggerTest, 
NodeAddedTriggerTest]
   [junit4] Completed [5/5 (4!)] on J1 in 25.87s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 14 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, 4 failures [seed: 
CA063B9166DD5B70]

Total time: 59 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   4/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=8f296d0ccf82174f9c612920ce25b928196a1fa8, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #21876
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to