Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/3204/
Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testSearchRate

Error Message:


Stack Trace:
java.util.ConcurrentModificationException
        at 
__randomizedtesting.SeedInfo.seed([E857361A83F9EABB:B51F28934C3F4CF4]:0)
        at 
java.base/java.util.ArrayList$Itr.checkForComodification(ArrayList.java:939)
        at java.base/java.util.ArrayList$Itr.next(ArrayList.java:893)
        at 
java.base/java.util.AbstractCollection.toString(AbstractCollection.java:472)
        at java.base/java.lang.String.valueOf(String.java:2801)
        at java.base/java.lang.StringBuilder.append(StringBuilder.java:135)
        at 
java.base/java.util.concurrent.ConcurrentHashMap.toString(ConcurrentHashMap.java:1341)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster.testSearchRate(TestSimLargeCluster.java:704)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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 
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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 14661 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.sim.TestSimLargeCluster_E857361A83F9EABB-001/init-core-data-001
   [junit4]   2> 1322555 INFO  
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1322556 INFO  
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1322556 INFO  
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1322558 DEBUG 
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10212_solr
   [junit4]   2> 1322558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1322558 DEBUG 
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 1322558 DEBUG 
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 1322558 INFO  
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1322558 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 1322559 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1322559 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1322559 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10230_solr, 127.0.0.1:10212_solr, 127.0.0.1:10218_solr, 
127.0.0.1:10226_solr, 127.0.0.1:10225_solr, 127.0.0.1:10229_solr, 
127.0.0.1:10228_solr, 127.0.0.1:10220_solr, 127.0.0.1:10215_solr, 
127.0.0.1:10223_solr, 127.0.0.1:10224_solr, 127.0.0.1:10213_solr, 
127.0.0.1:10217_solr, 127.0.0.1:10221_solr, 127.0.0.1:10219_solr, 
127.0.0.1:10216_solr, 127.0.0.1:10214_solr, 127.0.0.1:10222_solr, 
127.0.0.1:10227_solr]
   [junit4]   2> 1322560 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1322560 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1322560 INFO  (ScheduledTrigger-8449-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 38 and last live nodes: 19
   [junit4]   2> 1322564 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSearchRate
   [junit4]   2> 1322564 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 1322564 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1322565 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and clearing 
object cache...
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1322565 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 2
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion -1
   [junit4]   2> 1322565 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1322566 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10251_solr, 127.0.0.1:10296_solr, 127.0.0.1:10218_solr, 
127.0.0.1:10282_solr, 127.0.0.1:10249_solr, 127.0.0.1:10279_solr, 
127.0.0.1:10304_solr, 127.0.0.1:10234_solr, 127.0.0.1:10265_solr, 
127.0.0.1:10220_solr, 127.0.0.1:10281_solr, 127.0.0.1:10266_solr, 
127.0.0.1:10221_solr, 127.0.0.1:10219_solr, 127.0.0.1:10235_solr, 
127.0.0.1:10233_solr, 127.0.0.1:10236_solr, 127.0.0.1:10305_solr, 
127.0.0.1:10247_solr, 127.0.0.1:10252_solr, 127.0.0.1:10302_solr, 
127.0.0.1:10284_solr, 127.0.0.1:10298_solr, 127.0.0.1:10295_solr, 
127.0.0.1:10217_solr, 127.0.0.1:10222_solr, 127.0.0.1:10262_solr, 
127.0.0.1:10231_solr, 127.0.0.1:10215_solr, 127.0.0.1:10268_solr, 
127.0.0.1:10224_solr, 127.0.0.1:10263_solr, 127.0.0.1:10269_solr, 
127.0.0.1:10246_solr, 127.0.0.1:10285_solr, 127.0.0.1:10240_solr, 
127.0.0.1:10275_solr, 127.0.0.1:10278_solr, 127.0.0.1:10250_solr, 
127.0.0.1:10297_solr, 127.0.0.1:10300_solr, 127.0.0.1:10259_solr, 
127.0.0.1:10291_solr, 127.0.0.1:10294_solr, 127.0.0.1:10309_solr, 
127.0.0.1:10237_solr, 127.0.0.1:10253_solr, 127.0.0.1:10256_solr, 
127.0.0.1:10306_solr, 127.0.0.1:10303_solr, 127.0.0.1:10272_solr, 
127.0.0.1:10257_solr, 127.0.0.1:10212_solr, 127.0.0.1:10226_solr, 
127.0.0.1:10290_solr, 127.0.0.1:10273_solr, 127.0.0.1:10260_solr, 
127.0.0.1:10258_solr, 127.0.0.1:10213_solr, 127.0.0.1:10274_solr, 
127.0.0.1:10288_solr, 127.0.0.1:10243_solr, 127.0.0.1:10227_solr, 
127.0.0.1:10230_solr, 127.0.0.1:10308_solr, 127.0.0.1:10225_solr, 
127.0.0.1:10228_solr, 127.0.0.1:10241_solr, 127.0.0.1:10292_solr, 
127.0.0.1:10255_solr, 127.0.0.1:10310_solr, 127.0.0.1:10239_solr, 
127.0.0.1:10244_solr, 127.0.0.1:10287_solr, 127.0.0.1:10214_solr, 
127.0.0.1:10254_solr, 127.0.0.1:10293_solr, 127.0.0.1:10229_solr, 
127.0.0.1:10299_solr, 127.0.0.1:10271_solr, 127.0.0.1:10276_solr, 
127.0.0.1:10307_solr, 127.0.0.1:10223_solr, 127.0.0.1:10238_solr, 
127.0.0.1:10270_solr, 127.0.0.1:10301_solr, 127.0.0.1:10232_solr, 
127.0.0.1:10216_solr, 127.0.0.1:10277_solr, 127.0.0.1:10261_solr, 
127.0.0.1:10286_solr, 127.0.0.1:10289_solr, 127.0.0.1:10245_solr, 
127.0.0.1:10242_solr, 127.0.0.1:10280_solr, 127.0.0.1:10283_solr, 
127.0.0.1:10267_solr, 127.0.0.1:10311_solr, 127.0.0.1:10248_solr, 
127.0.0.1:10264_solr]
   [junit4]   2> 1322566 INFO  (ScheduledTrigger-8454-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322569 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1322569 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1322586 INFO  (ScheduledTrigger-8454-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322607 INFO  (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322627 INFO  (ScheduledTrigger-8454-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322647 INFO  (ScheduledTrigger-8454-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322667 INFO  (ScheduledTrigger-8454-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322688 INFO  (ScheduledTrigger-8454-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322708 INFO  (ScheduledTrigger-8454-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322728 INFO  (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322748 INFO  (ScheduledTrigger-8454-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1322766 DEBUG (simCloudManagerPool-8453-thread-1) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 1322766 DEBUG (simCloudManagerPool-8453-thread-1) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 1322767 DEBUG (simCloudManagerPool-8453-thread-1) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1322767 DEBUG (simCloudManagerPool-8453-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1322767 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
   [junit4]   2> 1322767 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1322767 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 1322768 DEBUG (simCloudManagerPool-8453-thread-2) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1322768 DEBUG (simCloudManagerPool-8453-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 1322768 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
   [junit4]   2> 1322768 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1322768 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1322768 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 1322768 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection testSearchRate, 
currentVersion=2
   [junit4]   2> 1322768 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=2
   [junit4]   2> 1322769 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 2
   [junit4]   2> 1322779 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=3
   [junit4]   2> 1322779 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 3
   [junit4]   2> 1322898 DEBUG (simCloudManagerPool-8453-thread-3) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection 
testSearchRate, currentVersion=4
   [junit4]   2> 1322906 DEBUG (simCloudManagerPool-8453-thread-4) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=4
   [junit4]   2> 1322906 DEBUG (simCloudManagerPool-8453-thread-4) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 4
   [junit4]   2> 1322917 DEBUG (simCloudManagerPool-8453-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=5
   [junit4]   2> 1322917 DEBUG (simCloudManagerPool-8453-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 5
   [junit4]   2> 1322927 DEBUG (simCloudManagerPool-8453-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=6
   [junit4]   2> 1322927 DEBUG (simCloudManagerPool-8453-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 6
   [junit4]   2> 1322938 DEBUG (simCloudManagerPool-8453-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=7
   [junit4]   2> 1322938 DEBUG (simCloudManagerPool-8453-thread-7) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 7
   [junit4]   2> 1322948 DEBUG (simCloudManagerPool-8453-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=8
   [junit4]   2> 1322948 DEBUG (simCloudManagerPool-8453-thread-8) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 8
   [junit4]   2> 1322959 DEBUG (simCloudManagerPool-8453-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=9
   [junit4]   2> 1322959 DEBUG (simCloudManagerPool-8453-thread-9) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 9
   [junit4]   2> 1322969 DEBUG (simCloudManagerPool-8453-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=10
   [junit4]   2> 1322969 DEBUG (simCloudManagerPool-8453-thread-10) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 10
   [junit4]   2> 1322980 DEBUG (simCloudManagerPool-8453-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=11
   [junit4]   2> 1322980 DEBUG (simCloudManagerPool-8453-thread-11) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 11
   [junit4]   2> 1322990 DEBUG (simCloudManagerPool-8453-thread-12) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=12
   [junit4]   2> 1322990 DEBUG (simCloudManagerPool-8453-thread-12) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 12
   [junit4]   2> 1323001 DEBUG (simCloudManagerPool-8453-thread-13) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=13
   [junit4]   2> 1323001 DEBUG (simCloudManagerPool-8453-thread-13) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 13
   [junit4]   2> 1323011 DEBUG (simCloudManagerPool-8453-thread-14) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=14
   [junit4]   2> 1323012 DEBUG (simCloudManagerPool-8453-thread-14) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 14
   [junit4]   2> 1323022 DEBUG (simCloudManagerPool-8453-thread-15) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=15
   [junit4]   2> 1323022 DEBUG (simCloudManagerPool-8453-thread-15) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 15
   [junit4]   2> 1323023 DEBUG (simCloudManagerPool-8453-thread-36) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard2 (currentVersion=16): {"core_node12":{
   [junit4]   2>     "core":"testSearchRate_shard2_replica_n12",
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10277_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1323033 DEBUG (simCloudManagerPool-8453-thread-16) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=16
   [junit4]   2> 1323033 DEBUG (simCloudManagerPool-8453-thread-16) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 16
   [junit4]   2> 1323043 DEBUG (simCloudManagerPool-8453-thread-17) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=17
   [junit4]   2> 1323044 DEBUG (simCloudManagerPool-8453-thread-17) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 17
   [junit4]   2> 1323054 DEBUG (simCloudManagerPool-8453-thread-18) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=18
   [junit4]   2> 1323054 DEBUG (simCloudManagerPool-8453-thread-18) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 18
   [junit4]   2> 1323064 DEBUG (simCloudManagerPool-8453-thread-19) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=19
   [junit4]   2> 1323065 DEBUG (simCloudManagerPool-8453-thread-19) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 19
   [junit4]   2> 1323075 DEBUG (simCloudManagerPool-8453-thread-20) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=20
   [junit4]   2> 1323075 DEBUG (simCloudManagerPool-8453-thread-20) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 20
   [junit4]   2> 1323086 DEBUG (simCloudManagerPool-8453-thread-21) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=21
   [junit4]   2> 1323086 DEBUG (simCloudManagerPool-8453-thread-21) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 21
   [junit4]   2> 1323096 DEBUG (simCloudManagerPool-8453-thread-22) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=22
   [junit4]   2> 1323096 DEBUG (simCloudManagerPool-8453-thread-22) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 22
   [junit4]   2> 1323107 DEBUG (simCloudManagerPool-8453-thread-23) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=23
   [junit4]   2> 1323107 DEBUG (simCloudManagerPool-8453-thread-23) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 23
   [junit4]   2> 1323107 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=24
   [junit4]   2> 1323107 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 24
   [junit4]   2> 1323108 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.CloudTestUtils -- shards without leaders: [shard1]
   [junit4]   2> 1323108 DEBUG (simCloudManagerPool-8453-thread-24) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard1 (currentVersion=25): {"core_node1":{
   [junit4]   2>     "core":"testSearchRate_shard1_replica_n1",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10264_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1323109 INFO  (simCloudManagerPool-8453-thread-34) [    ] 
o.a.s.c.ActionThrottle Throttling leader attempts - waiting for 702ms
   [junit4]   2> 1323123 DEBUG (simCloudManagerPool-8453-thread-34) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for testSearchRate / 
shard2 (currentVersion=25): {"core_node11":{
   [junit4]   2>     "core":"testSearchRate_shard2_replica_n11",
   [junit4]   2>     "shard":"shard2",
   [junit4]   2>     "collection":"testSearchRate",
   [junit4]   2>     "node_name":"127.0.0.1:10261_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1323124 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=25
   [junit4]   2> 1323124 DEBUG 
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 25
   [junit4]   2> 1323124 INFO  
(TEST-TestSimLargeCluster.testSearchRate-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.TestSimLargeCluster Ready after 11297 ms
   [junit4]   2> 1323126 DEBUG (simCloudManagerPool-8453-thread-46) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1323126 DEBUG (simCloudManagerPool-8453-thread-46) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
5
   [junit4]   2> 1323126 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
   [junit4]   2> 1323126 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1323126 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1323126 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323127 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (simCloudManagerPool-8453-thread-47) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (simCloudManagerPool-8453-thread-47) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
6
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 1323128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1323128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323128 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323129 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323149 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323150 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323171 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323192 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323193 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323213 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323214 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10276_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10307_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10223_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10238_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10270_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10301_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10232_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10216_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10277_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10261_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10286_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n10:QUERY./select.requestTimes:1minRate
 4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10289_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n9:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10245_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n8:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10242_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n7:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10280_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n6:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10283_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n5:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10267_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n4:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10311_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n3:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10248_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n2:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ### rates for node 127.0.0.1:10264_solr
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ###  
metrics:solr.core.testSearchRate.shard1.replica_n1:QUERY./select.requestTimes:1minRate
  4
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ## Collection: testSearchRate
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##  - shard1
   [junit4]   2> 1323235 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n10  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n9  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n8  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n7  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n6  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n5  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n4  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n3  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n2  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger ##     testSearchRate_shard1_replica_n1  4.0
   [junit4]   2> 1323236 DEBUG (ScheduledTrigger-8454-thread-4) [    ] 
o.a.s.c.a.SearchRateTrigger -- testSearchRate.shard1: totalShardRate=40.0, 
shardRate=4.0
   [junit4]   2> 1323237 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- simCreateCollection .system, 
currentVersion=26
   [junit4]   2> 1323237 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=26
   [junit4]   2> 1323238 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 26
   [junit4]   2> 1323248 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=27
   [junit4]   2> 1323248 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 27
   [junit4]   2> 1323276 DEBUG (simCloudManagerPool-8453-thread-50) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=28
   [junit4]   2> 1323276 DEBUG (simCloudManagerPool-8453-thread-50) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 28
   [junit4]   2> 1323287 DEBUG (simCloudManagerPool-8453-thread-49) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=29
   [junit4]   2> 1323287 DEBUG (simCloudManagerPool-8453-thread-49) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 29
   [junit4]   2> 1323298 DEBUG (simCloudManagerPool-8453-thread-51) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=30
   [junit4]   2> 1323298 DEBUG (simCloudManagerPool-8453-thread-51) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 30
   [junit4]   2> 1323298 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- finished createCollection .system, 
currentVersion=31
   [junit4]   2> 1323298 INFO  (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.CloudTestUtils -- shards without leaders: [shard1]
   [junit4]   2> 1323298 DEBUG (simCloudManagerPool-8453-thread-52) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for .system / shard1 
(currentVersion=31): {"core_node2":{
   [junit4]   2>     "core":".system_shard1_replica_n2",
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     "collection":".system",
   [junit4]   2>     "node_name":"127.0.0.1:10299_solr",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>     "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>     "INDEX.sizeInBytes":10240,
   [junit4]   2>     "state":"active",
   [junit4]   2>     "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>     "SEARCHER.searcher.numDocs":0}}
   [junit4]   2> 1323300 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=31
   [junit4]   2> 1323301 DEBUG (simCloudManagerPool-8453-thread-48) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 31
   [junit4]   2> 1323301 DEBUG (AutoscalingActionExecutor-8455-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction -- processing event: {
   [junit4]   2>   "id":"6a62488f6dcefT3m8vv37cscbleq4086j77vuob",
   [junit4]   2>   "source":"search_rate_trigger",
   [junit4]   2>   "eventTime":1871525707177199,
   [junit4]   2>   "eventType":"SEARCHRATE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "hotReplicas":[
   [junit4]   2>       {"core_node10":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n10",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10286_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node9":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n9",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10289_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node8":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n8",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10245_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node7":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n7",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10242_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node6":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n6",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10280_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node5":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n5",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10283_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node4":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n4",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10267_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node3":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n3",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10311_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node2":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n2",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10248_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node1":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n1",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10264_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}}],
   [junit4]   2>     "coldNodes":{},
   [junit4]   2>     "coldShards":{},
   [junit4]   2>     "coldReplicas":[],
   [junit4]   2>     "violationType":["hotShards"],
   [junit4]   2>     "coldCollections":{},
   [junit4]   2>     "hotShards":{"testSearchRate":{"shard1":4.0}},
   [junit4]   2>     "hotCollections":{"testSearchRate":40.0},
   [junit4]   2>     "hotNodes":{
   [junit4]   2>       "127.0.0.1:10242_solr":4.0,
   [junit4]   2>       "127.0.0.1:10245_solr":4.0,
   [junit4]   2>       "127.0.0.1:10286_solr":4.0,
   [junit4]   2>       "127.0.0.1:10280_solr":4.0,
   [junit4]   2>       "127.0.0.1:10283_solr":4.0,
   [junit4]   2>       "127.0.0.1:10267_solr":4.0,
   [junit4]   2>       "127.0.0.1:10311_solr":4.0,
   [junit4]   2>       "127.0.0.1:10289_solr":4.0,
   [junit4]   2>       "127.0.0.1:10248_solr":4.0,
   [junit4]   2>       "127.0.0.1:10264_solr":4.0},
   [junit4]   2>     "_enqueue_time_":1871531103123749,
   [junit4]   2>     "requestedOps":[{
   [junit4]   2>         "action":"ADDREPLICA",
   [junit4]   2>         "hints":{"COLL_SHARD":[{
   [junit4]   2>               "first":"testSearchRate",
   [junit4]   2>               "second":"shard1"}]}}]}} with context 
properties: {BEFORE_ACTION=[compute]}
   [junit4]   2> 1323308 DEBUG (AutoscalingActionExecutor-8455-thread-1) [    ] 
o.a.s.c.a.ComputePlanAction Computed Plan: 
action=ADDREPLICA&collection=testSearchRate&shard=shard1&node=127.0.0.1:10293_solr&type=NRT
   [junit4]   2> 1323308 DEBUG (AutoscalingActionExecutor-8455-thread-1) [    ] 
o.a.s.c.a.ExecutePlanAction -- processing event: {
   [junit4]   2>   "id":"6a62488f6dcefT3m8vv37cscbleq4086j77vuob",
   [junit4]   2>   "source":"search_rate_trigger",
   [junit4]   2>   "eventTime":1871525707177199,
   [junit4]   2>   "eventType":"SEARCHRATE",
   [junit4]   2>   "properties":{
   [junit4]   2>     "hotReplicas":[
   [junit4]   2>       {"core_node10":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n10",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10286_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node9":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n9",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10289_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node8":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n8",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10245_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node7":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n7",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10242_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node6":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n6",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10280_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node5":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n5",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10283_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node4":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n4",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10267_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node3":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n3",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10311_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node2":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n2",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10248_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}},
   [junit4]   2>       {"core_node1":{
   [junit4]   2>           "core":"testSearchRate_shard1_replica_n1",
   [junit4]   2>           "shard":"shard1",
   [junit4]   2>           "collection":"testSearchRate",
   [junit4]   2>           "node_name":"127.0.0.1:10264_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true",
   [junit4]   2>           "SEARCHER.searcher.maxDoc":0,
   [junit4]   2>           "SEARCHER.searcher.deletedDocs":0,
   [junit4]   2>           "INDEX.sizeInBytes":10240,
   [junit4]   2>           "rate":4.0,
   [junit4]   2>           "state":"active",
   [junit4]   2>           "QUERY./select.requestTimes:1minRate":4,
   [junit4]   2>           "INDEX.sizeInGB":9.5367431640625E-6,
   [junit4]   2>           "SEARCHER.searcher.numDocs":0}}],
   [junit4]   2>     "__start__":1,
   [junit4]   2>     "coldNodes":{},
   [junit4]   2>     "coldShards":{},
   [junit4]   2>     "coldReplicas":[],
   [junit4]   2>     "violationType":["hotShards"],
   [junit4]   2>     "coldCollections":{},
   [junit4]   2>     "hotShards":{"testSearchRate":{"shard1":4.0}},
   [junit4]   2>     "hotCollections":{"testSearchRate":40.0},
   [junit4]   2>     "hotNodes":{
   [junit4]   2>       "127.0.0.1:10242_solr":4.0,
   [junit4]   2>       "127.0.0.1:10245_solr":4.0,
   [junit4]   2>       "127.0.0.1:10286_solr":4.0,
   [junit4]   2>       "127.0.0.1:10280_solr":4.0,
   [junit4]   2>       "127.0.0.1:10283_solr":4.0,
   [junit4]   2>       "127.0.0.1:10267_solr":4.0,
   [junit4]   2>       "127.0.0.1:10311_solr":4.0,
   [junit4]   2>       "127.0.0.1:10289_solr":4.0,
   [junit4]   2>       "127.0

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

.. 6 more
   [junit4]   2> 1358982 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1358987 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider --- new Overseer leader: 
127.0.0.1:10432_solr
   [junit4]   2> 1358987 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1358988 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 1358988 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1358988 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1358989 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=0
   [junit4]   2> 1358989 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 0
   [junit4]   2> 1358989 INFO  
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 1358989 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:10432_solr]
   [junit4]   2> 1358989 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1358989 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1358989 INFO  (ScheduledTrigger-8467-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 1358993 INFO  
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAddNode
   [junit4]   2> 1358993 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** creating new collection states, 
currentVersion=1
   [junit4]   2> 1358994 DEBUG 
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimClusterStateProvider ** saved cluster state version 1
   [junit4]   2> 1358994 INFO  
(TEST-TestSimLargeCluster.testAddNode-seed#[E857361A83F9EABB]) [    ] 
o.a.s.c.a.s.SimSolrCloudTestCase #######################################
   [junit4]   2> ############ CLUSTER STATE ############
   [junit4]   2> #######################################
   [junit4]   2> ## Live nodes:         100
   [junit4]   2> ## Empty nodes:        100
   [junit4]   2> ## Dead nodes:         0
   [junit4]   2> ## Collections:
   [junit4]   2> ## Max replicas per node:      0
   [junit4]   2> ## Min replicas per node:      0
   [junit4]   2> ## Total replicas:             0
   [junit4]   2> ######### Solr op counts ##########
   [junit4]   2> ######### Autoscaling event counts ###########
   [junit4]   2> 
   [junit4] IGNOR/A 0.00s J1 | TestSimLargeCluster.testBasic
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl="https://issues.apache.org/jira/browse/SOLR-12028";))
   [junit4] IGNOR/A 0.00s J1 | TestSimLargeCluster.testNodeLost
   [junit4]    > Assumption #1: 'badapple' test group is disabled 
(@BadApple(bugUrl="https://issues.apache.org/jira/browse/SOLR-12028";))
   [junit4]   2> 1358995 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 1358995 DEBUG 
(SUITE-TestSimLargeCluster-seed#[E857361A83F9EABB]-worker) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.sim.TestSimLargeCluster_E857361A83F9EABB-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1063, maxMBSortInHeap=5.365536517280933, 
sim=RandomSimilarity(queryNorm=false): {}, locale=ar-ER, 
timezone=Pacific/Enderbury
   [junit4]   2> NOTE: Linux 4.15.0-39-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=1,free=308429536,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SaslZkACLProviderTest, 
TestRecovery, MergeStrategyTest, RegexBoostProcessorTest, 
DocValuesNotIndexedTest, PropertiesRequestHandlerTest, 
IgnoreLargeDocumentProcessorFactoryTest, TestCloudJSONFacetSKG, 
TestPolicyCloud, CurrencyFieldTypeTest, TestReversedWildcardFilterFactory, 
LeaderTragicEventTest, TestSimComputePlanAction, MetricUtilsTest, 
BasicDistributedZkTest, TestRTGBase, TestManagedResourceStorage, TestBadConfig, 
TestSystemCollAutoCreate, SolrMetricReporterTest, RangeFacetCloudTest, 
TestDynamicLoading, EmbeddedSolrNoSerializeTest, DOMUtilTest, UpdateLogTest, 
TestUtilizeNode, UUIDFieldTest, BlockJoinFacetDistribTest, 
TestCloudManagedSchema, MetricsConfigTest, TestStressCloudBlindAtomicUpdates, 
TestSolrCoreSnapshots, TestRandomFaceting, TestMissingGroups, TaggerTest, 
TestCollectionsAPIViaSolrCloudCluster, TestSolrDeletionPolicy1, 
SearchRateTriggerIntegrationTest, TestNumericTerms32, CheckHdfsIndexTest, 
TestIBSimilarityFactory, PluginInfoTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, PrimUtilsTest, 
TestFieldTypeResource, StressHdfsTest, 
TestOverriddenPrefixQueryForCustomFieldType, TestCloudDeleteByQuery, 
TestCopyFieldCollectionResource, CdcrWithNodesRestartsTest, 
DistributedQueryComponentOptimizationTest, MultiSolrCloudTestCaseTest, 
CreateRoutedAliasTest, MinimalSchemaTest, DocValuesMissingTest, 
TestConfigSetsAPIExclusivity, SynonymTokenizerTest, 
ConfigureRecoveryStrategyTest, ExecutePlanActionTest, 
HttpPartitionOnCommitTest, TlogReplayBufferedWhileIndexingTest, 
TestFieldSortValues, TestRTimerTree, TestNonDefinedSimilarityFactory, 
TestChildDocTransformer, SolrSlf4jReporterTest, TestSchemaSimilarityResource, 
TestSystemIdResolver, PolyFieldTest, TestSortableTextField, 
DistributedSuggestComponentTest, CloudMLTQParserTest, TestSimpleQParserPlugin, 
RestartWhileUpdatingTest, RecoveryAfterSoftCommitTest, 
SolrCoreCheckLockOnStartupTest, AssignBackwardCompatibilityTest, 
OverseerModifyCollectionTest, DistributedFacetPivotLongTailTest, 
SoftAutoCommitTest, HLLSerializationTest, SharedFSAutoReplicaFailoverTest, 
IndexSizeTriggerTest, ConfigSetsAPITest, 
DocExpirationUpdateProcessorFactoryTest, TestManagedSchemaAPI, 
SolrCloudExampleTest, TestRandomFlRTGCloud, BasicFunctionalityTest, 
TestFieldCacheReopen, DistribJoinFromCollectionTest, TestCoreAdminApis, 
TestReplicaProperties, TestReqParamsAPI, TestManagedSynonymGraphFilterFactory, 
TestCSVLoader, HdfsBasicDistributedZkTest, NodeAddedTriggerIntegrationTest, 
TestEmbeddedSolrServerSchemaAPI, TestRuleBasedAuthorizationPlugin, 
TestLockTree, TestMacros, DistributedExpandComponentTest, TestSimPolicyCloud, 
XmlUpdateRequestHandlerTest, ActionThrottleTest, TestCloudSearcherWarming, 
TestLeaderElectionWithEmptyReplica, TestShardHandlerFactory, 
TestFoldingMultitermQuery, PrimitiveFieldTypeTest, TestPhraseSuggestions, 
TestTrackingShardHandlerFactory, CloneFieldUpdateProcessorFactoryTest, 
TestApiFramework, LIRRollingUpdatesTest, RulesTest, TestTlogReplica, 
TestDownShardTolerantSearch, DataDrivenBlockJoinTest, DeleteNodeTest, 
TestShortCircuitedRequests, CollectionStateFormat2Test, TestScoreJoinQPNoScore, 
ClassificationUpdateProcessorFactoryTest, TestPrepRecovery, RankQueryTest, 
ResponseBuilderTest, SubstringBytesRefFilterTest, TestStressReorder, 
TestUnInvertedFieldException, ShowFileRequestHandlerTest, 
TestUniqueKeyFieldResource, HdfsTlogReplayBufferedWhileIndexingTest, 
GraphQueryTest, TestCloudPseudoReturnFields, TestDeleteCollectionOnDownNodes, 
TestExclusionRuleCollectionAccess, TestRebalanceLeaders, ZkControllerTest, 
ZkFailoverTest, CollectionReloadTest, CollectionsAPIDistributedZkTest, 
AutoAddReplicasIntegrationTest, ScheduledMaintenanceTriggerTest, 
SearchRateTriggerTest, TestSimDistribStateManager, TestSimDistributedQueue, 
TestSimExecutePlanAction, TestSimExtremeIndexing, 
TestSimGenericDistributedQueue, TestSimLargeCluster]
   [junit4] Completed [534/836 (1!)] on J1 in 36.45s, 4 tests, 1 error, 2 
skipped <<< FAILURES!

[...truncated 43477 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/3204/consoleText

[repro] Revision: 2b62f8be407eaeece98411efc3ded5184af478ec

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=TestSimLargeCluster 
-Dtests.method=testSearchRate -Dtests.seed=E857361A83F9EABB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-ER 
-Dtests.timezone=Pacific/Enderbury -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       TestSimLargeCluster
[repro] ant compile-test

[...truncated 3610 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.TestSimLargeCluster" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=E857361A83F9EABB 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-ER 
-Dtests.timezone=Pacific/Enderbury -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8

[...truncated 95 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.cloud.autoscaling.sim.TestSimLargeCluster
[repro] Exiting with code 0

[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to