Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1298/
Java: 64bit/jdk1.8.0_162 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
4 tests failed.
FAILED: org.apache.solr.cloud.HttpPartitionTest.test
Error Message:
max version bucket seed not updated after recovery!
Stack Trace:
java.lang.AssertionError: max version bucket seed not updated after recovery!
at
__randomizedtesting.SeedInfo.seed([103570B8CAEEFF24:98614F62641292DC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.HttpPartitionTest.testRf2(HttpPartitionTest.java:441)
at
org.apache.solr.cloud.HttpPartitionTest.test(HttpPartitionTest.java:140)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at
__randomizedtesting.SeedInfo.seed([103570B8CAEEFF24:471C8B0D111C1D3F]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:725)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate
Error Message:
The trigger did not fire at all
Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
at
__randomizedtesting.SeedInfo.seed([103570B8CAEEFF24:4D7D6E310528596B]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate(TestLargeCluster.java:547)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory
Error Message:
expected:<5> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<0>
at
__randomizedtesting.SeedInfo.seed([103570B8CAEEFF24:7DC9D44570A60023]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:265)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11747 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestLargeCluster
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.sim.TestLargeCluster_103570B8CAEEFF24-001/init-core-data-001
[junit4] 2> 5460 WARN
(SUITE-TestLargeCluster-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
[junit4] 2> 5460 INFO
(SUITE-TestLargeCluster-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 5461 INFO
(SUITE-TestLargeCluster-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 5461 INFO
(SUITE-TestLargeCluster-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 5472 INFO
(SUITE-TestLargeCluster-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 5524 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSearchRate
[junit4] 2> 5527 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and clearing
object cache...
[junit4] 2> 5528 DEBUG
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 5535 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 5539 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 5542 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
1
[junit4] 2> 5578 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 5578 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
[junit4] 2> 5578 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 5586 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 5587 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 5588 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5610 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5631 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5652 DEBUG (ScheduledTrigger-32-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5664 DEBUG (simCloudManagerPool-31-thread-1) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 5667 DEBUG (simCloudManagerPool-31-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
2
[junit4] 2> 5670 DEBUG (simCloudManagerPool-31-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 5671 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 5672 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 5672 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 5673 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5686 DEBUG (simCloudManagerPool-31-thread-2) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 5687 DEBUG (simCloudManagerPool-31-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 5687 DEBUG (simCloudManagerPool-31-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 5687 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 5688 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 5688 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 5693 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5714 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5734 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5754 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5775 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5795 DEBUG (ScheduledTrigger-32-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5815 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5836 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5856 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5877 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5897 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5918 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5951 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5982 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 5982 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.TestLargeCluster Ready after 95 ms
[junit4] 2> 5984 DEBUG (simCloudManagerPool-31-thread-25) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate /
shard1: {"core_node1":{
[junit4] 2> "node_name":"127.0.0.1:10061_solr",
[junit4] 2> "core":"testSearchRate_shard1_replica_n1",
[junit4] 2> "leader":"true",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInBytes":1000000000,
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testSearchRate"}}
[junit4] 2> 5988 DEBUG (simCloudManagerPool-31-thread-24) [ ]
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate /
shard2: {"core_node18":{
[junit4] 2> "node_name":"127.0.0.1:10083_solr",
[junit4] 2> "core":"testSearchRate_shard2_replica_n18",
[junit4] 2> "leader":"true",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "INDEX.sizeInBytes":1000000000,
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testSearchRate"}}
[junit4] 2> 6003 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6023 DEBUG (ScheduledTrigger-32-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6048 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6069 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6089 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6110 DEBUG (ScheduledTrigger-32-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6130 DEBUG (ScheduledTrigger-32-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6137 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}}
[junit4] 2> 6138 DEBUG (ScheduledTrigger-32-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
search_rate_trigger]
[junit4] 2> 6156 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "_enqueue_time_":542036078655427,
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}}
[junit4] 2> 6205 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ComputePlanAction -- processing event: {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "_enqueue_time_":542036078655427,
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}} with context
properties: {BEFORE_ACTION=[compute]}
[junit4] 2> 6256 INFO (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ComputePlanAction Computed Plan:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10072_solr&type=NRT
[junit4] 2> 6262 INFO (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ComputePlanAction Computed Plan:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10056_solr&type=NRT
[junit4] 2> 6265 INFO (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ComputePlanAction Computed Plan:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10059_solr&type=NRT
[junit4] 2> 6265 INFO (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.s.c.a.PolicyHelper returnSession, curr-time 542042428
sessionWrapper.createTime 542040911817827, this.sessionWrapper.createTime
542040911817827
[junit4] 2> 6267 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ExecutePlanAction -- processing event: {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "__start__":1,
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "_enqueue_time_":542036078655427,
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}} with context
properties:
{operations=[org.apache.solr.client.solrj.request.CollectionAdminRequest$AddReplica@3b5cca85,
org.apache.solr.client.solrj.request.CollectionAdminRequest$AddReplica@3a3b7ff6,
org.apache.solr.client.solrj.request.CollectionAdminRequest$AddReplica@79011b89],
AFTER_ACTION=[compute], BEFORE_ACTION=[compute, execute]}
[junit4] 2> 6274 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ExecutePlanAction Executing operation:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10072_solr&type=NRT
[junit4] 2> 6293 INFO (simCloudManagerPool-31-thread-27) [ ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:10072_solr for creating new
replica
[junit4] 2> 6312 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ExecutePlanAction Executing operation:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10056_solr&type=NRT
[junit4] 2> 6313 INFO (simCloudManagerPool-31-thread-32) [ ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:10056_solr for creating new
replica
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testSearchRate
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase
[junit4] 2>
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase #############################################
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ############ FINAL CLUSTER STATS ############
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase #############################################
[junit4] 2>
[junit4] 2> 6388 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Live nodes: 100
[junit4] 2> 6389 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Empty nodes: 78
[junit4] 2> 6389 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Dead nodes: 0
[junit4] 2> 6390 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Collections: [testSearchRate]
[junit4] 2> 6390 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Max replicas per node: 1
[junit4] 2> 6390 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Min replicas per node: 0
[junit4] 2> 6390 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## Total replicas: 22
[junit4] 2> 6390 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## * testSearchRate 22
[junit4] 2> 6390 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ExecutePlanAction Executing operation:
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10059_solr&type=NRT
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - active 22
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ######### Final Solr op counts ##########
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - ADDREPLICA 2
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - CREATE 1
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - DELETESTATUS 2
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - REQUESTSTATUS 2
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - autoscaling 2
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - update 1
[junit4] 2> 6391 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ######### Autoscaling event counts ###########
[junit4] 2> 6392 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: search_rate_trigger
[junit4] 2> 6392 INFO
(TEST-TestLargeCluster.testSearchRate-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLargeCluster
-Dtests.method=testSearchRate -Dtests.seed=103570B8CAEEFF24
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=nl
-Dtests.timezone=America/Halifax -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.89s J1 | TestLargeCluster.testSearchRate <<<
[junit4] > Throwable #1: java.lang.AssertionError: The trigger did not
fire at all
[junit4] > at
__randomizedtesting.SeedInfo.seed([103570B8CAEEFF24:4D7D6E310528596B]:0)
[junit4] > at
org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate(TestLargeCluster.java:547)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 6407 INFO
(TEST-TestLargeCluster.testAddNode-seed#[103570B8CAEEFF24]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testAddNode
[junit4] 2> 6407 DEBUG
(TEST-TestLargeCluster.testAddNode-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
4
[junit4] 2> 6407 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
[junit4] 2> 6420 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 6420 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 6420 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 6424 INFO
(TEST-TestLargeCluster.testAddNode-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and clearing
object cache...
[junit4] 2> 6424 WARN (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are
closed, exiting.
[junit4] 2> 6426 WARN (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Exception executing actions
[junit4] 2> java.lang.Exception: Error executing action: execute for
trigger event: {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "__start__":1,
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "_enqueue_time_":542036078655427,
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}}
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:303)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unexpected
exception while processing event: {
[junit4] 2> "id":"1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85",
[junit4] 2> "source":"search_rate_trigger",
[junit4] 2> "eventTime":542029546527977,
[junit4] 2> "eventType":"SEARCHRATE",
[junit4] 2> "properties":{
[junit4] 2> "node":{
[junit4] 2> "127.0.0.1:10001_solr":4.0,
[junit4] 2> "127.0.0.1:10040_solr":4.0,
[junit4] 2> "127.0.0.1:10085_solr":4.0,
[junit4] 2> "127.0.0.1:10061_solr":4.0,
[junit4] 2> "127.0.0.1:10068_solr":4.0,
[junit4] 2> "127.0.0.1:10089_solr":4.0,
[junit4] 2> "127.0.0.1:10029_solr":4.0,
[junit4] 2> "127.0.0.1:10030_solr":4.0,
[junit4] 2> "127.0.0.1:10080_solr":4.0,
[junit4] 2> "127.0.0.1:10023_solr":4.0},
[junit4] 2> "__start__":1,
[junit4] 2> "replica":[
[junit4] 2> "{\"core_node4\":{\n
\"core\":\"testSearchRate_shard1_replica_n4\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10001_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node9\":{\n
\"core\":\"testSearchRate_shard1_replica_n9\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10023_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node1\":{\n
\"core\":\"testSearchRate_shard1_replica_n1\",\n \"leader\":\"true\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10061_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node2\":{\n
\"core\":\"testSearchRate_shard1_replica_n2\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10089_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node8\":{\n
\"core\":\"testSearchRate_shard1_replica_n8\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10029_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node3\":{\n
\"core\":\"testSearchRate_shard1_replica_n3\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10080_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node5\":{\n
\"core\":\"testSearchRate_shard1_replica_n5\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10030_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node10\":{\n
\"core\":\"testSearchRate_shard1_replica_n10\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10040_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node6\":{\n
\"core\":\"testSearchRate_shard1_replica_n6\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10085_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}",
[junit4] 2> "{\"core_node7\":{\n
\"core\":\"testSearchRate_shard1_replica_n7\",\n
\"INDEX.sizeInBytes\":1000000000,\n \"rate\":4.0,\n
\"node_name\":\"127.0.0.1:10068_solr\",\n \"state\":\"active\",\n
\"type\":\"NRT\",\n \"QUERY./select.requestTimes:1minRate\":4.0,\n
\"shard\":\"shard1\",\n \"collection\":\"testSearchRate\"}}"],
[junit4] 2> "collection":{"testSearchRate":40.0},
[junit4] 2> "shard":{"testSearchRate":{"shard1":40.0}},
[junit4] 2> "_enqueue_time_":542036078655427,
[junit4] 2> "requestedOps":[
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}",
[junit4] 2> "Op{action=ADDREPLICA, hints={COLL_SHARD={\n
\"first\":\"testSearchRate\",\n \"second\":\"shard1\"}}}"]}}
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:120)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:300)
[junit4] 2> ... 6 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unexpected
exception executing operation:
action=ADDREPLICA&async=search_rate_trigger/1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85/0&waitForFinalState=true&collection=testSearchRate&shard=shard1&node=127.0.0.1:10059_solr&type=NRT
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:110)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: java.io.IOException: java.lang.InterruptedException
[junit4] 2> at
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:462)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.ExecutePlanAction.process(ExecutePlanAction.java:80)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404)
[junit4] 2> at
java.util.concurrent.FutureTask.get(FutureTask.java:191)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.sim.SimCloudManager.request(SimCloudManager.java:460)
[junit4] 2> ... 8 more
[junit4] 2> 6430 DEBUG (AutoscalingActionExecutor-33-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 13730 ms for event
id=1ecf916941ce9T8bf4v1rtkvf2a8u9eatj5do85
[junit4] 2> 6438 DEBUG
(TEST-TestLargeCluster.testAddNode-seed#[103570B8CAEEFF24]) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 6440 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 6441 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
5
[junit4] 2> 6441 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 6441 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion -1
[junit4] 2> 6441 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
[junit4] 2> 6442 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 6442 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
[junit4] 2> 6442 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6462 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6483 DEBUG (ScheduledTrigger-35-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6503 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6524 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6544 DEBUG (ScheduledTrigger-35-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6554 DEBUG (simCloudManagerPool-34-thread-1) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 6555 DEBUG (simCloudManagerPool-34-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
6
[junit4] 2> 6555 DEBUG (simCloudManagerPool-34-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 6557 DEBUG (simCloudManagerPool-34-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10082_solr,
127.0.0.1:10004_solr, 127.0.0.1:10018_solr, 127.0.0.1:10049_solr,
127.0.0.1:10020_solr, 127.0.0.1:10065_solr, 127.0.0.1:10021_solr,
127.0.0.1:10005_solr, 127.0.0.1:10066_solr, 127.0.0.1:10035_solr,
127.0.0.1:10051_solr, 127.0.0.1:10019_solr, 127.0.0.1:10096_solr,
127.0.0.1:10022_solr, 127.0.0.1:10033_solr, 127.0.0.1:10017_solr,
127.0.0.1:10047_solr, 127.0.0.1:10095_solr, 127.0.0.1:10081_solr,
127.0.0.1:10084_solr, 127.0.0.1:10036_solr, 127.0.0.1:10052_solr,
127.0.0.1:10006_solr, 127.0.0.1:10079_solr, 127.0.0.1:10098_solr,
127.0.0.1:10003_solr, 127.0.0.1:10001_solr, 127.0.0.1:10054_solr,
127.0.0.1:10099_solr, 127.0.0.1:10071_solr, 127.0.0.1:10023_solr,
127.0.0.1:10076_solr, 127.0.0.1:10007_solr, 127.0.0.1:10055_solr,
127.0.0.1:10010_solr, 127.0.0.1:10016_solr, 127.0.0.1:10070_solr,
127.0.0.1:10077_solr, 127.0.0.1:10038_solr, 127.0.0.1:10032_solr,
127.0.0.1:10093_solr, 127.0.0.1:10061_solr, 127.0.0.1:10067_solr,
127.0.0.1:10086_solr, 127.0.0.1:10089_solr, 127.0.0.1:10045_solr,
127.0.0.1:10042_solr, 127.0.0.1:10029_solr, 127.0.0.1:10083_solr,
127.0.0.1:10080_solr, 127.0.0.1:10048_solr, 127.0.0.1:10064_solr,
127.0.0.1:10043_solr, 127.0.0.1:10057_solr, 127.0.0.1:10074_solr,
127.0.0.1:10026_solr, 127.0.0.1:10012_solr, 127.0.0.1:10060_solr,
127.0.0.1:10073_solr, 127.0.0.1:10058_solr, 127.0.0.1:10013_solr,
127.0.0.1:10090_solr, 127.0.0.1:10088_solr, 127.0.0.1:10027_solr,
127.0.0.1:10039_solr, 127.0.0.1:10025_solr, 127.0.0.1:10044_solr,
127.0.0.1:10028_solr, 127.0.0.1:10092_solr, 127.0.0.1:10041_solr,
127.0.0.1:10087_solr, 127.0.0.1:10009_solr, 127.0.0.1:10000_solr,
127.0.0.1:10030_solr, 127.0.0.1:10014_solr, 127.0.0.1:10011_solr,
127.0.0.1:10040_solr, 127.0.0.1:10085_solr, 127.0.0.1:10046_solr,
127.0.0.1:10068_solr, 127.0.0.1:10063_solr, 127.0.0.1:10015_solr,
127.0.0.1:10069_solr, 127.0.0.1:10062_solr, 127.0.0.1:10008_solr,
127.0.0.1:10024_solr, 127.0.0.1:10050_solr, 127.0.0.1:10075_solr,
127.0.0.1:10078_solr, 127.0.0.1:10002_solr, 127.0.0.1:10097_solr,
127.0.0.1:10031_solr, 127.0.0.1:10034_solr, 127.0.0.1:10091_solr,
127.0.0.1:10094_solr, 127.0.0.1:10037_solr, 127.0.0.1:10053_solr,
127.0.0.1:10059_solr, 127.0.0.1:10056_solr, 127.0.0.1:10072_solr]
[junit4] 2> 6558 DEBUG (simCloudManagerPool-34-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated
with properties: {event=nodeAdded, waitFor=5, actions=[{name=compute,
class=org.apache.solr.cloud.autoscaling.ComputePlanAction}, {name=execute,
class=org.apache.solr.cloud.autoscaling.ExecutePlanAction}], enabled=true}
[junit4] 2> 6558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6
[junit4] 2> 6559 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ]
o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6
[junit4] 2> 6564 DEBUG (ScheduledTrigger-35-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6559 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6578 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6585 DEBUG (ScheduledTrigger-35-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6606 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6606 DEBUG (ScheduledTrigger-35-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6606 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6626 DEBUG (ScheduledTrigger-35-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6626 DEBUG (ScheduledTrigger-35-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6626 DEBUG (ScheduledTrigger-35-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6646 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6646 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6646 DEBUG (ScheduledTrigger-35-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6667 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6667 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6667 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6734 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6734 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6734 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6755 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 100
[junit4] 2> 6755 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 6755 DEBUG (ScheduledTrigger-35-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 100
[junit4] 2> 6775 DEBUG (ScheduledTrigger-35-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .au
[...truncated too long message...]
000000) closing
[junit4] 2> 2948732 INFO
(OverseerStateUpdate-72093305252282375-127.0.0.1:37365_solr-n_0000000000)
[n:127.0.0.1:37365_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:37365_solr
[junit4] 2> 2948732 WARN
(OverseerAutoScalingTriggerThread-72093305252282375-127.0.0.1:37365_solr-n_0000000000)
[n:127.0.0.1:37365_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2948733 DEBUG (jetty-closer-7155-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 2948733 INFO (jetty-closer-7155-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6cafe69c{/solr,null,UNAVAILABLE}
[junit4] 2> 2948733 INFO
(zkCallback-7177-thread-1-processing-n:127.0.0.1:35993_solr)
[n:127.0.0.1:35993_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:35993_solr
[junit4] 2> 2948733 INFO (jetty-closer-7155-thread-2) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2948733 WARN
(zkCallback-7177-thread-3-processing-n:127.0.0.1:35993_solr)
[n:127.0.0.1:35993_solr ] o.a.s.c.LeaderElector Our node is no longer in
line to be leader
[junit4] 2> 2948734 INFO (coreCloseExecutor-9373-thread-1)
[n:127.0.0.1:35993_solr c:AutoscalingHistoryHandlerTest_collection s:shard1
r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader,
tag=1680755723
[junit4] 2> 2948734 INFO (coreCloseExecutor-9373-thread-2)
[n:127.0.0.1:35993_solr c:.system s:shard1 r:core_node10
x:.system_shard1_replica_n9] o.a.s.m.SolrMetricManager Closing metric reporters
for registry=solr.collection..system.shard1.leader, tag=83761704
[junit4] 2> 2948735 INFO (jetty-closer-7155-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7ab836c3{/solr,null,UNAVAILABLE}
[junit4] 2> 2948735 INFO (jetty-closer-7155-thread-1) [ ]
o.e.j.s.session Stopped scavenging
[junit4] 2> 2948736 ERROR
(SUITE-AutoscalingHistoryHandlerTest-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2948736 INFO
(SUITE-AutoscalingHistoryHandlerTest-seed#[103570B8CAEEFF24]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39683 39683
[junit4] 2> 2950213 INFO (Thread-6653) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:39683 39683
[junit4] 2> 2950214 WARN (Thread-6653) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 24 /solr/collections/.system/terms/shard1
[junit4] 2> 19
/solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
[junit4] 2> 13 /solr/aliases.json
[junit4] 2> 5 /solr/configs/.system
[junit4] 2> 5 /solr/configs/.system/managed-schema
[junit4] 2> 4 /solr/security.json
[junit4] 2> 4
/solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 4
/solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 59 /solr/collections/.system/state.json
[junit4] 2> 40
/solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 13 /solr/clusterprops.json
[junit4] 2> 13 /solr/clusterstate.json
[junit4] 2> 3
/solr/collections/.system/leader_elect/shard1/election/72093305252282375-core_node5-n_0000000001
[junit4] 2> 2
/solr/collections/AutoscalingHistoryHandlerTest_collection/leader_elect/shard1/election/72093305252282376-core_node5-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/72093305252282375-127.0.0.1:37365_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 13 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_103570B8CAEEFF24-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{action_s=FST50,
event.source_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
type=PostingsFormat(name=LuceneFixedGap),
before.actions_ss=Lucene50(blocksize=128),
event.property._enqueue_time__ss=FST50, after.actions_ss=FST50, stage_s=FST50,
event.id_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
event.property.eventTimes_ss=PostingsFormat(name=LuceneFixedGap),
source_s=PostingsFormat(name=LuceneVarGapDocFreqInterval),
event.type_s=PostingsFormat(name=LuceneFixedGap), responses_ts=FST50,
id=PostingsFormat(name=LuceneVarGapDocFreqInterval),
collections_ss=PostingsFormat(name=LuceneFixedGap), operations.params_ts=FST50,
event.property.nodeNames_ss=PostingsFormat(name=LuceneFixedGap)},
docValues:{_version_=DocValuesFormat(name=Memory),
event.time_l=DocValuesFormat(name=Asserting),
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=185,
maxMBSortInHeap=6.972922376327813, sim=RandomSimilarity(queryNorm=true): {},
locale=es-BO, timezone=Asia/Ho_Chi_Minh
[junit4] 2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation
1.8.0_162 (64-bit)/cpus=8,threads=1,free=264588624,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [BadIndexSchemaTest,
TestMiniSolrCloudClusterSSL, BinaryUpdateRequestHandlerTest,
TestSolrDeletionPolicy1, TestIndexSearcher, ShardRoutingTest, MoveReplicaTest,
FacetPivotSmallTest, TestFieldCacheSort, HttpPartitionOnCommitTest,
HighlighterConfigTest, TestPullReplica, ZkStateReaderTest, UpdateParamsTest,
SolrIndexSplitterTest, TestConfigSets, TestOmitPositions,
ReplicationFactorTest, TestSolrQueryParser, TestInitParams, UUIDFieldTest,
HdfsDirectoryFactoryTest, TestInPlaceUpdatesStandalone,
TestEmbeddedSolrServerSchemaAPI, TestCollationField, TestCrossCoreJoin,
TestFieldTypeResource, TestDocSet, TestCryptoKeys, HdfsBasicDistributedZk2Test,
OverseerModifyCollectionTest, TestNumericRangeQuery32, ZkSolrClientTest,
ComputePlanActionTest, TestBlendedInfixSuggestions,
TestTolerantUpdateProcessorCloud, CursorPagingTest,
TestRandomRequestDistribution, TestDocTermOrds, PluginInfoTest,
TestLegacyNumericRangeQueryBuilder, TestSolrQueryResponse,
TestCloudNestedDocsSort, TestCSVResponseWriter, SpellingQueryConverterTest,
TestUniqueKeyFieldResource, UtilsToolTest, DirectUpdateHandlerTest,
TestRTimerTree, TestRemoteStreaming, TestCustomSort, NumberUtilsTest,
CreateCollectionCleanupTest, TestIndexingPerformance,
AutoAddReplicasIntegrationTest, TestCollapseQParserPlugin,
TestSubQueryTransformerCrossCore, TestGraphMLResponseWriter,
ChangedSchemaMergeTest, ShufflingReplicaListTransformerTest,
TestLegacyNumericUtils, TestExtendedDismaxParser, SolrRequestParserTest,
TestSolrCloudWithKerberosAlt, SpatialRPTFieldTypeTest, TestStressUserVersions,
MetricsHandlerTest, TolerantUpdateProcessorTest, TestRawResponseWriter,
TestSizeLimitedDistributedMap, HttpTriggerListenerTest, CheckHdfsIndexTest,
CoreSorterTest, DistributedQueryComponentCustomSortTest, DeleteShardTest,
TestConfigOverlay, IndexBasedSpellCheckerTest, TestDownShardTolerantSearch,
JavabinLoaderTest, SparseHLLTest, DocumentAnalysisRequestHandlerTest,
CdcrBootstrapTest, DefaultValueUpdateProcessorTest, SimpleMLTQParserTest,
CursorMarkTest, JSONWriterTest, TestShardHandlerFactory,
BlockJoinFacetRandomTest, DocValuesMissingTest,
PeerSyncWithIndexFingerprintCachingTest, CollectionReloadTest,
TermVectorComponentDistributedTest, TestStressLucene, RuleEngineTest,
ExternalFileFieldSortTest, SSLMigrationTest, ConcurrentCreateRoutedAliasTest,
TestFastOutputStream, TestWriterPerf, TestConfig, TestDistributedSearch,
AssignBackwardCompatibilityTest, RankQueryTest,
TestSolrConfigHandlerConcurrent, OutputWriterTest, TestSort, TestPolicyCloud,
TestSlowCompositeReaderWrapper, MissingSegmentRecoveryTest, HdfsThreadLeakTest,
TestRandomFaceting, TestMultiWordSynonyms, RemoteQueryErrorTest,
ChaosMonkeyNothingIsSafeTest, DistribDocExpirationUpdateProcessorTest,
TestCopyFieldCollectionResource, TestNodeLostTrigger,
TestLuceneIndexBackCompat, TestGroupingSearch, TestStreamBody,
OutOfBoxZkACLAndCredentialsProvidersTest, StatsComponentTest,
TestCloudJSONFacetJoinDomain, TestLuceneMatchVersion, V2StandaloneTest,
SolrJmxReporterCloudTest, TestWordDelimiterFilterFactory,
BasicDistributedZk2Test, SyncSliceTest, LeaderElectionIntegrationTest,
RecoveryZkTest, FullSolrCloudDistribCmdsTest, ZkCLITest, TestFaceting,
ZkControllerTest, TestJoin, TestCoreContainer, SimpleFacetsTest, TestFiltering,
TestBadConfig, HighlighterTest, SoftAutoCommitTest,
ChaosMonkeySafeLeaderWithPullReplicasTest, CleanupOldIndexTest,
ConnectionManagerTest, DeleteInactiveReplicaTest,
DeleteLastCustomShardedReplicaTest, DeleteNodeTest,
DistribJoinFromCollectionTest, DistributedQueueTest, ForceLeaderTest,
ReplaceNodeTest, TestAuthenticationFramework, TestCloudRecovery,
TestClusterProperties, TestConfigSetsAPI, TestLeaderElectionZkExpiry,
TestLockTree, TestOnReconnectListenerSupport, TestRandomFlRTGCloud,
TestRebalanceLeaders, TestSkipOverseerOperations,
TestStressCloudBlindAtomicUpdates, TestTlogReplica, ZkShardTermsTest,
CollectionTooManyReplicasTest, CollectionsAPIAsyncDistributedZkTest,
HdfsCollectionsAPIDistributedZkTest, ShardSplitTest, TestInfoStreamLogging,
TestNRTOpen, TestSolrXml, RequestLoggingTest, TestConfigReload,
TestReplicationHandlerBackup, TestSQLHandler, AutoscalingHistoryHandlerTest]
[junit4] Completed [651/774 (4!)] on J0 in 37.00s, 1 test, 1 failure <<<
FAILURES!
[...truncated 48656 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
