Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23450/
Java: 64bit/jdk1.8.0_172 -XX:+UseCompressedOops -XX:+UseSerialGC

7 tests failed.
FAILED:  org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode

Error Message:
no STARTED event

Stack Trace:
java.lang.AssertionError: no STARTED event
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:8A62B8032B28BD5C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode(TestSimLargeCluster.java:318)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testAddNode

Error Message:
no STARTED event

Stack Trace:
java.lang.AssertionError: no STARTED event
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:8A62B8032B28BD5C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode(TestSimLargeCluster.java:318)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testAddNode

Error Message:
no STARTED event

Stack Trace:
java.lang.AssertionError: no STARTED event
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:8A62B8032B28BD5C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode(TestSimLargeCluster.java:318)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testAddNode

Error Message:
no STARTED event

Stack Trace:
java.lang.AssertionError: no STARTED event
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:8A62B8032B28BD5C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode(TestSimLargeCluster.java:318)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testNodeLost

Error Message:
no STARTED event: [], waitFor=5, killDelay=5000, minIgnored=0

Stack Trace:
java.lang.AssertionError: no STARTED event: [], waitFor=5, killDelay=5000, 
minIgnored=0
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:92986B5E678F57C2]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.doTestNodeLost(TestSimLargeCluster.java:522)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost(TestSimLargeCluster.java:366)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testNodeLost

Error Message:
no STARTED event: [], waitFor=5, killDelay=5000, minIgnored=0

Stack Trace:
java.lang.AssertionError: no STARTED event: [], waitFor=5, killDelay=5000, 
minIgnored=0
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:92986B5E678F57C2]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.doTestNodeLost(TestSimLargeCluster.java:522)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost(TestSimLargeCluster.java:366)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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.sim.TestSimLargeCluster.testNodeLost

Error Message:
no STARTED event: [], waitFor=5, killDelay=5000, minIgnored=0

Stack Trace:
java.lang.AssertionError: no STARTED event: [], waitFor=5, killDelay=5000, 
minIgnored=0
        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:92986B5E678F57C2]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.doTestNodeLost(TestSimLargeCluster.java:522)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost(TestSimLargeCluster.java:366)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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 14600 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.sim.TestSimLargeCluster_2D8DA5A0E4653244-001/init-core-data-001
   [junit4]   2> 1459082 WARN  
(SUITE-TestSimLargeCluster-seed#[2D8DA5A0E4653244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
   [junit4]   2> 1459082 INFO  
(SUITE-TestSimLargeCluster-seed#[2D8DA5A0E4653244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1459084 INFO  
(SUITE-TestSimLargeCluster-seed#[2D8DA5A0E4653244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1459084 INFO  
(SUITE-TestSimLargeCluster-seed#[2D8DA5A0E4653244]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1459086 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSearchRate
   [junit4]   2> 1459090 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10208_solr
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 1459090 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 1459090 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 1459090 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10208_solr, 127.0.0.1:10209_solr, 127.0.0.1:10210_solr, 
127.0.0.1:10211_solr]
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
   [junit4]   2> 1459090 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1459090 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 7 and last live nodes: 4
   [junit4]   2> 1459098 DEBUG (simCloudManagerPool-12087-thread-2) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1459098 DEBUG (simCloudManagerPool-12087-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 1459099 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1459099 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
   [junit4]   2> 1459099 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1459101 DEBUG (ScheduledTrigger-12088-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 7
   [junit4]   2> 1459103 DEBUG (simCloudManagerPool-12087-thread-4) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1459103 DEBUG (simCloudManagerPool-12087-thread-4) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1459103 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 1459103 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
   [junit4]   2> 1459103 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 1459103 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testSearchRate, 
currentVersion=1
   [junit4]   2> 1459103 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 1459103 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 1459109 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=2
   [junit4]   2> 1459109 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
   [junit4]   2> 1459256 DEBUG (simCloudManagerPool-12087-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=3
   [junit4]   2> 1459256 DEBUG (simCloudManagerPool-12087-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
   [junit4]   2> 1459261 DEBUG (simCloudManagerPool-12087-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=4
   [junit4]   2> 1459262 DEBUG (simCloudManagerPool-12087-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
   [junit4]   2> 1459267 DEBUG (simCloudManagerPool-12087-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=5
   [junit4]   2> 1459268 DEBUG (simCloudManagerPool-12087-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
   [junit4]   2> 1459273 DEBUG (simCloudManagerPool-12087-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=6
   [junit4]   2> 1459273 DEBUG (simCloudManagerPool-12087-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
   [junit4]   2> 1459279 DEBUG (simCloudManagerPool-12087-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=7
   [junit4]   2> 1459279 DEBUG (simCloudManagerPool-12087-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
   [junit4]   2> 1459285 DEBUG (simCloudManagerPool-12087-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=8
   [junit4]   2> 1459285 DEBUG (simCloudManagerPool-12087-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 8
   [junit4]   2> 1459291 DEBUG (simCloudManagerPool-12087-thread-12) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=9
   [junit4]   2> 1459291 DEBUG (simCloudManagerPool-12087-thread-12) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 9
   [junit4]   2> 1459297 DEBUG (simCloudManagerPool-12087-thread-13) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=10
   [junit4]   2> 1459297 DEBUG (simCloudManagerPool-12087-thread-13) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 10
   [junit4]   2> 1459303 DEBUG (simCloudManagerPool-12087-thread-14) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=11
   [junit4]   2> 1459303 DEBUG (simCloudManagerPool-12087-thread-14) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 11
   [junit4]   2> 1459309 DEBUG (simCloudManagerPool-12087-thread-15) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=12
   [junit4]   2> 1459309 DEBUG (simCloudManagerPool-12087-thread-15) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 12
   [junit4]   2> 1459315 DEBUG (simCloudManagerPool-12087-thread-16) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=13
   [junit4]   2> 1459315 DEBUG (simCloudManagerPool-12087-thread-16) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 13
   [junit4]   2> 1459320 DEBUG (simCloudManagerPool-12087-thread-17) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=14
   [junit4]   2> 1459321 DEBUG (simCloudManagerPool-12087-thread-17) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 14
   [junit4]   2> 1459327 DEBUG (simCloudManagerPool-12087-thread-18) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=15
   [junit4]   2> 1459327 DEBUG (simCloudManagerPool-12087-thread-18) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 15
   [junit4]   2> 1459328 DEBUG (simCloudManagerPool-12087-thread-40) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard2 (currentVersion=16): {"core_node12":{
   [junit4]   2>     "core":"testSearchRate_shard2_replica_n12",
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10277_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1459333 DEBUG (simCloudManagerPool-12087-thread-19) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=16
   [junit4]   2> 1459333 DEBUG (simCloudManagerPool-12087-thread-19) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 16
   [junit4]   2> 1459339 DEBUG (simCloudManagerPool-12087-thread-20) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=17
   [junit4]   2> 1459339 DEBUG (simCloudManagerPool-12087-thread-20) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 17
   [junit4]   2> 1459345 DEBUG (simCloudManagerPool-12087-thread-21) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=18
   [junit4]   2> 1459345 DEBUG (simCloudManagerPool-12087-thread-21) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 18
   [junit4]   2> 1459351 DEBUG (simCloudManagerPool-12087-thread-22) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=19
   [junit4]   2> 1459351 DEBUG (simCloudManagerPool-12087-thread-22) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 19
   [junit4]   2> 1459357 DEBUG (simCloudManagerPool-12087-thread-23) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=20
   [junit4]   2> 1459357 DEBUG (simCloudManagerPool-12087-thread-23) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 20
   [junit4]   2> 1459358 DEBUG (simCloudManagerPool-12087-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection 
testSearchRate, currentVersion=21
   [junit4]   2> 1459363 DEBUG (simCloudManagerPool-12087-thread-24) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=21
   [junit4]   2> 1459363 DEBUG (simCloudManagerPool-12087-thread-24) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 21
   [junit4]   2> 1459369 DEBUG (simCloudManagerPool-12087-thread-25) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=22
   [junit4]   2> 1459370 DEBUG (simCloudManagerPool-12087-thread-25) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 22
   [junit4]   2> 1459370 DEBUG (simCloudManagerPool-12087-thread-26) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard1 (currentVersion=23): {"core_node1":{
   [junit4]   2>     "core":"testSearchRate_shard1_replica_n1",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10264_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1459371 INFO  (simCloudManagerPool-12087-thread-36) [    ] 
o.a.s.c.ActionThrottle Throttling leader attempts - waiting for 679ms
   [junit4]   2> 1459378 DEBUG (simCloudManagerPool-12087-thread-36) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard2 (currentVersion=23): {"core_node11":{
   [junit4]   2>     "core":"testSearchRate_shard2_replica_n11",
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10261_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1459379 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=23
   [junit4]   2> 1459379 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 23
   [junit4]   2> 1459379 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.TestSimLargeCluster Ready after 2165 ms
   [junit4]   2> 1459379 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=24
   [junit4]   2> 1459380 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 24
   [junit4]   2> 1459382 DEBUG (simCloudManagerPool-12087-thread-49) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1459382 DEBUG (simCloudManagerPool-12087-thread-49) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 1459382 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 1459382 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
   [junit4]   2> 1459382 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 1459383 DEBUG (simCloudManagerPool-12087-thread-50) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1459384 DEBUG (simCloudManagerPool-12087-thread-50) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
5
   [junit4]   2> 1459384 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
   [junit4]   2> 1459384 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
   [junit4]   2> 1459384 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1459385 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
        4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10210_solr
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459386 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1459387 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1459395 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
        4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10210_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1459406 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1459407 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1459417 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1459417 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1459417 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1459417 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1459417 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
        4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10210_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1459418 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
        4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10210_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1459429 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1459430 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1459440 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
        4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10210_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1459441 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1459447 DEBUG (ScheduledTrigger-12088-thread-2) [    ] 
o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
   [junit4]   2>   "id":"532a015181146T8xvuhshz66c0rgfrl96v1qzaa",
   [junit4]   2>   "source":"search_rate_trigger",
   [junit4]   2>   "eventTime":1463038013608262,
   [junit4]   2>   "eventType":"SEARCHRATE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "hotReplicas":[
   [junit4]   2>       {"core_node10":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n10",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10286_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node9":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n9",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10210_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node8":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n8",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10289_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node7":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n7",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10245_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node6":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n6",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10242_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node5":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n5",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10280_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node4":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n4",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10283_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node3":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n3",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10267_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node2":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n2",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10248_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node1":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n1",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10264_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}}],
   [junit4]   2>     "coldNodes":{},
   [junit4]   2>     "coldShards":{},
   [junit4]   2>     "coldReplicas":[],
   [junit4]   2>     "violationType":["hotShards"],
   [junit4]   2>     "coldCollections":{},
   [junit4]   2>     "hotShards":{"testSearchRate":{"shard1":4.0}},
   [junit4]   2>     "hotCollections":{"testSearchRate":40.0},
   [junit4]   2>     "hotNodes":{
   [junit4]   2>       "127.0.0.1:10242_solr":4.0,
   [junit4]   2>       "127.0.0.1:10245_solr":4.0,
   [junit4]   2>       "127.0.0.1:10286_solr":4.0,
   [junit4]   2>       "127.0.0.1:10280_solr":4.0,
   [junit4]   2>       "127.0.0.1:10283_solr":4.0,
   [junit4]   2>       "127.0.0.1:10267_solr":4.0,
   [junit4]   2>       "127.0.0.1:10210_solr":4.0,
   [junit4]   2>       "127.0.0.1:10289_solr":4.0,
   [junit4]   2>       "127.0.0.1:10248_solr":4.0,
   [junit4]   2>       "127.0.0.1:10264_solr":4.0},
   [junit4]   2>     "_enqueue_time_":1463043976384262,
   [junit4]   2>     "requestedOps":[{
   [junit4]   2>         "action":"ADDREPLICA",
   [junit4]   2>         "hints":{"COLL_SHARD":[{
   [junit4]   2>               "first":"testSearchRate",
   [junit4]   2>               "second":"shard1"}]}}]}}
   [junit4]   2> 1459448 DEBUG (AutoscalingActionExecutor-12089-thread-1) [    
] o.a.s.c.a.ComputePlanAction -- processing event: {
   [junit4] 

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

 "eventTime":1403181282067305,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[
   [junit4]   2>       1403181282067305,
   [junit4]   2>       1403181280200905,
   [junit4]   2>       1403181280796305,
   [junit4]   2>       1403181281241105,
   [junit4]   2>       1403181281647905],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":1403213199718705,
   [junit4]   2>     "nodeNames":[
   [junit4]   2>       "127.0.0.1:10549_solr",
   [junit4]   2>       "127.0.0.1:10620_solr",
   [junit4]   2>       "127.0.0.1:10634_solr",
   [junit4]   2>       "127.0.0.1:10618_solr",
   [junit4]   2>       "127.0.0.1:10581_solr"]}}, exception: 
java.io.IOException: already closed
   [junit4]   2> 40995 WARN  (AutoscalingActionExecutor-34-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers Exception executing actions
   [junit4]   2> org.apache.solr.cloud.autoscaling.TriggerActionException: 
Error processing action for trigger event: {
   [junit4]   2>   "id":"4fc2f99df8369T8xvuhshz66c0rgfrl96v1qqke",
   [junit4]   2>   "source":"node_lost_trigger3",
   [junit4]   2>   "eventTime":1403181282067305,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[
   [junit4]   2>       1403181282067305,
   [junit4]   2>       1403181280200905,
   [junit4]   2>       1403181280796305,
   [junit4]   2>       1403181281241105,
   [junit4]   2>       1403181281647905],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":1403213199718705,
   [junit4]   2>     "nodeNames":[
   [junit4]   2>       "127.0.0.1:10549_solr",
   [junit4]   2>       "127.0.0.1:10620_solr",
   [junit4]   2>       "127.0.0.1:10634_solr",
   [junit4]   2>       "127.0.0.1:10618_solr",
   [junit4]   2>       "127.0.0.1:10581_solr"]}}
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:327)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 
~[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_172]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Unexpected 
exception while processing event: {
   [junit4]   2>   "id":"4fc2f99df8369T8xvuhshz66c0rgfrl96v1qqke",
   [junit4]   2>   "source":"node_lost_trigger3",
   [junit4]   2>   "eventTime":1403181282067305,
   [junit4]   2>   "eventType":"NODELOST",
   [junit4]   2>   "properties":{
   [junit4]   2>     "eventTimes":[
   [junit4]   2>       1403181282067305,
   [junit4]   2>       1403181280200905,
   [junit4]   2>       1403181280796305,
   [junit4]   2>       1403181281241105,
   [junit4]   2>       1403181281647905],
   [junit4]   2>     "preferredOperation":"movereplica",
   [junit4]   2>     "_enqueue_time_":1403213199718705,
   [junit4]   2>     "nodeNames":[
   [junit4]   2>       "127.0.0.1:10549_solr",
   [junit4]   2>       "127.0.0.1:10620_solr",
   [junit4]   2>       "127.0.0.1:10634_solr",
   [junit4]   2>       "127.0.0.1:10618_solr",
   [junit4]   2>       "127.0.0.1:10581_solr"]}}
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ComputePlanAction.process(ComputePlanAction.java:160)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:324)
 ~[java/:?]
   [junit4]   2>        ... 6 more
   [junit4]   2> Caused by: java.lang.InterruptedException: stopping - thread 
was interrupted
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ComputePlanAction.process(ComputePlanAction.java:112)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:324)
 ~[java/:?]
   [junit4]   2>        ... 6 more
   [junit4]   2> 40996 DEBUG (AutoscalingActionExecutor-34-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -- processing took 55181 ms for event 
id=4fc2f99df8369T8xvuhshz66c0rgfrl96v1qqke
   [junit4]   2> 40996 DEBUG 
(TEST-TestSimLargeCluster.testNodeLost-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool 
executor
   [junit4]   2> 40996 DEBUG 
(TEST-TestSimLargeCluster.testNodeLost-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 40996 DEBUG 
(TEST-TestSimLargeCluster.testNodeLost-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 40998 INFO  
(TEST-TestSimLargeCluster.testNodeLost-seed#[2D8DA5A0E4653244]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testNodeLost
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSimLargeCluster 
-Dtests.method=testNodeLost -Dtests.seed=2D8DA5A0E4653244 -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.badapples=true -Dtests.locale=ru-RU 
-Dtests.timezone=Mexico/BajaSur -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 6.90s J2 | TestSimLargeCluster.testNodeLost <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: no STARTED event: [], 
waitFor=5, killDelay=5000, minIgnored=0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([2D8DA5A0E4653244:92986B5E678F57C2]:0)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.doTestNodeLost(TestSimLargeCluster.java:522)
   [junit4]    >        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost(TestSimLargeCluster.java:366)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.sim.TestSimLargeCluster_2D8DA5A0E4653244-002
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3f98c01c),
 locale=ru-RU, timezone=Mexico/BajaSur
   [junit4]   2> NOTE: Linux 4.15.0-42-generic amd64/Oracle Corporation 
1.8.0_172 (64-bit)/cpus=8,threads=1,free=423677968,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TestSimLargeCluster, 
TestSimLargeCluster]
   [junit4] Completed [5/5 (5!)] on J2 in 17.56s, 4 tests, 2 failures, 1 
skipped <<< FAILURES!
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: 2D8DA5A0E4653244]:
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testAddNode
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost
   [junit4]   - 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testNodeLost
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.67 ..    39.58 =    38.91s
   [junit4] JVM J1:     0.41 ..    23.90 =    23.49s
   [junit4] JVM J2:     0.66 ..    41.91 =    41.24s
   [junit4] Execution time total: 41 seconds
   [junit4] Tests summary: 5 suites, 20 tests, 10 failures, 5 ignored (5 
assumptions)

BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1572: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1099: 
There were test failures: 5 suites, 20 tests, 10 failures, 5 ignored (5 
assumptions) [seed: 2D8DA5A0E4653244]

Total time: 43 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   5/5 failed: org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster
[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=a1c6e642aad90d3615b4c71bf261a5aad7e32369, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #23449
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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to