Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/445/

4 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testMetricTrigger

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([16955A36D998FE70:AC996DB98670283F]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at org.junit.Assert.assertNull(Assert.java:562)
        at 
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testMetricTrigger(TriggerIntegrationTest.java:1589)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate

Error Message:
The trigger did not fire at all

Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
        at 
__randomizedtesting.SeedInfo.seed([16955A36D998FE70:4BDD44BF165E583F]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.sim.TestLargeCluster.testSearchRate(TestLargeCluster.java:547)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory

Error Message:
expected:<5> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<0>
        at 
__randomizedtesting.SeedInfo.seed([16955A36D998FE70:7B69FECB63D00177]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:311)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple

Error Message:
Waiting for collection testSimple1 null Live Nodes: [127.0.0.1:36812_solr, 
127.0.0.1:39742_solr] Last available state: 
DocCollection(testSimple1//collections/testSimple1/state.json/19)={   
"pullReplicas":"0",   "replicationFactor":"2",   "shards":{     "shard1":{      
 "range":"80000000-ffffffff",       "state":"active",       "replicas":{        
 "core_node5":{           "core":"testSimple1_shard1_replica_n2",           
"base_url":"http://127.0.0.1:36812/solr";,           
"node_name":"127.0.0.1:36812_solr",           "state":"active",           
"type":"NRT",           "leader":"true"},         "core_node12":{           
"core":"testSimple1_shard1_replica_n11",           
"base_url":"http://127.0.0.1:36812/solr";,           
"node_name":"127.0.0.1:36812_solr",           "state":"active",           
"type":"NRT"}}},     "shard2":{       "range":"0-7fffffff",       
"state":"active",       "replicas":{         "core_node8":{           
"core":"testSimple1_shard2_replica_n6",           
"base_url":"http://127.0.0.1:36812/solr";,           
"node_name":"127.0.0.1:36812_solr",           "state":"active",           
"type":"NRT",           "leader":"true"},         "core_node10":{           
"core":"testSimple1_shard2_replica_n9",           
"base_url":"http://127.0.0.1:41970/solr";,           
"node_name":"127.0.0.1:41970_solr",           "state":"down",           
"type":"NRT"}}}},   "router":{"name":"compositeId"},   "maxShardsPerNode":"2",  
 "autoAddReplicas":"true",   "nrtReplicas":"2",   "tlogReplicas":"0"}

Stack Trace:
java.lang.AssertionError: Waiting for collection testSimple1
null
Live Nodes: [127.0.0.1:36812_solr, 127.0.0.1:39742_solr]
Last available state: 
DocCollection(testSimple1//collections/testSimple1/state.json/19)={
  "pullReplicas":"0",
  "replicationFactor":"2",
  "shards":{
    "shard1":{
      "range":"80000000-ffffffff",
      "state":"active",
      "replicas":{
        "core_node5":{
          "core":"testSimple1_shard1_replica_n2",
          "base_url":"http://127.0.0.1:36812/solr";,
          "node_name":"127.0.0.1:36812_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"},
        "core_node12":{
          "core":"testSimple1_shard1_replica_n11",
          "base_url":"http://127.0.0.1:36812/solr";,
          "node_name":"127.0.0.1:36812_solr",
          "state":"active",
          "type":"NRT"}}},
    "shard2":{
      "range":"0-7fffffff",
      "state":"active",
      "replicas":{
        "core_node8":{
          "core":"testSimple1_shard2_replica_n6",
          "base_url":"http://127.0.0.1:36812/solr";,
          "node_name":"127.0.0.1:36812_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"},
        "core_node10":{
          "core":"testSimple1_shard2_replica_n9",
          "base_url":"http://127.0.0.1:41970/solr";,
          "node_name":"127.0.0.1:41970_solr",
          "state":"down",
          "type":"NRT"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"2",
  "autoAddReplicas":"true",
  "nrtReplicas":"2",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([16955A36D998FE70:2E267EC8FE6B2AA1]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
        at 
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple(AutoAddReplicasIntegrationTest.java:103)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12668 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> 1590774 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/init-core-data-001
   [junit4]   2> 1590775 WARN  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1590775 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1590793 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1590793 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/tempDir-001
   [junit4]   2> 1590793 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1590794 INFO  (Thread-2214) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1590794 INFO  (Thread-2214) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1590795 ERROR (Thread-2214) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1590894 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:35796
   [junit4]   2> 1590896 INFO  (zkConnectionManagerCallback-1825-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1590908 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1590908 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1590909 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1590909 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1590917 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1590917 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1590917 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1590917 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1590918 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4b23763b{/solr,null,AVAILABLE}
   [junit4]   2> 1590918 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@616ca207{/solr,null,AVAILABLE}
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@694194fd{HTTP/1.1,[http/1.1]}{127.0.0.1:34678}
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@18312bf9{HTTP/1.1,[http/1.1]}{127.0.0.1:38956}
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.e.j.s.Server Started @1598123ms
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.e.j.s.Server Started @1598123ms
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34678}
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38956}
   [junit4]   2> 1590919 ERROR (jetty-launcher-1822-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1590919 ERROR (jetty-launcher-1822-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 1590919 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1590920 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1590920 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1590920 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1590920 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-24T06:17:02.948Z
   [junit4]   2> 1590920 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-24T06:17:02.948Z
   [junit4]   2> 1590950 INFO  (zkConnectionManagerCallback-1829-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1590950 INFO  (zkConnectionManagerCallback-1827-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1590950 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1590950 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1590985 INFO  (jetty-launcher-1822-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35796/solr
   [junit4]   2> 1591015 INFO  (zkConnectionManagerCallback-1833-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1591016 INFO  (jetty-launcher-1822-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35796/solr
   [junit4]   2> 1591018 INFO  (zkConnectionManagerCallback-1837-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1591031 INFO  
(zkConnectionManagerCallback-1839-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1591032 INFO  
(zkConnectionManagerCallback-1841-thread-1-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1591584 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1591584 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:34678_solr
   [junit4]   2> 1591585 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer Overseer 
(id=72174931249397766-127.0.0.1:34678_solr-n_0000000000) starting
   [junit4]   2> 1591674 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1591675 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38956_solr
   [junit4]   2> 1591738 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1591767 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 1591767 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 1591768 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: []
   [junit4]   2> 1591768 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 1591768 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 1591778 INFO  
(zkCallback-1838-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1591790 INFO  
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1591806 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1591806 DEBUG 
(OverseerAutoScalingTriggerThread-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1591840 DEBUG (ScheduledTrigger-3496-thread-1) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1591851 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34678_solr
   [junit4]   2> 1591878 INFO  
(zkCallback-1840-thread-1-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1592002 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:34678_solr"} current state version: 0
   [junit4]   2> 1592002 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:34678_solr
   [junit4]   2> 1592003 INFO  
(zkCallback-1838-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1592084 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38956.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592107 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38956.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592120 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38956.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592121 INFO  (jetty-launcher-1822-thread-1) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/tempDir-001/node1/.
   [junit4]   2> 1592224 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34678.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592292 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34678.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592292 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34678.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1592293 INFO  (jetty-launcher-1822-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/tempDir-001/node2/.
   [junit4]   2> 1592424 INFO  (zkConnectionManagerCallback-1847-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1592443 INFO  (zkConnectionManagerCallback-1851-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1592444 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1592457 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35796/solr ready
   [junit4]   2> 1592470 INFO  (qtp1314610907-8517) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:38956_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1592587 INFO  
(OverseerThreadFactory-3499-thread-1-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 1592607 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":".system",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "numShards":1,
   [junit4]   2>   "createNodeSet":"127.0.0.1:38956_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 1592621 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: .system
   [junit4]   2> 1592622 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/.system/state.json
   [junit4]   2> 1592708 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1592708 INFO  
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1592709 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 1592709 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node2":{
   [junit4]   2>       "core":".system_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1592809 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 0
   [junit4]   2> 1592843 DEBUG (ScheduledTrigger-3496-thread-1) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 1592925 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1592925 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1592939 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1592939 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1592939 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node2:{"core":".system_shard1_replica_n1","base_url":"http://127.0.0.1:38956/solr","node_name":"127.0.0.1:38956_solr","state":"down","type":"NRT"}
   [junit4]   2> 1592939 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(.system//collections/.system/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           "core":".system_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1593050 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 1
   [junit4]   2> 1593051 INFO  
(zkCallback-1838-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1593052 INFO  
(zkCallback-1838-thread-2-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1593855 DEBUG (ScheduledTrigger-3496-thread-2) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 1593981 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1594002 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema.xml instead
   [junit4]   2> 1594017 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection 
or core
   [junit4]   2> 1594038 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 1594054 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at 
/configs/.system/managed-schema
   [junit4]   2> 1594055 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in 
ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to 
/configs/.system/schema.xml.bak
   [junit4]   2> 1594055 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using 
configuration from collection .system, trusted=true
   [junit4]   2> 1594056 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38956.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@669991
   [junit4]   2> 1594056 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1594056 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
[[.system_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/tempDir-001/node1/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_16955A36D998FE70-001/tempDir-001/node1/./.system_shard1_replica_n1/data/]
   [junit4]   2> 1594316 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1594316 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1594317 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommited docs 
   [junit4]   2> 1594317 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1594335 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@218776bf[.system_shard1_replica_n1] 
main]
   [junit4]   2> 1594336 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/.system
   [junit4]   2> 1594336 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/.system
   [junit4]   2> 1594336 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/.system/managed-schema
   [junit4]   2> 1594337 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1594337 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1594351 INFO  
(searcherExecutor-3503-thread-1-processing-n:127.0.0.1:38956_solr 
x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node2) 
[n:127.0.0.1:38956_solr c:.system s:shard1 r:core_node2 
x:.system_shard1_replica_n1] o.a.s.c.SolrCore [.system_shard1_replica_n1] 
Registered new searcher Searcher@218776bf[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1594351 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1593261976588386304
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:38956/solr/.system_shard1_replica_n1/
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy http://127.0.0.1:38956/solr/.system_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 1594380 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1594391 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:38956/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 1594395 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 1594496 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 2
   [junit4]   2> 1594513 INFO  
(zkCallback-1838-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1594513 INFO  
(zkCallback-1838-thread-2-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1594542 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1594544 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1594544 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1594544 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node2:{"core":".system_shard1_replica_n1","base_url":"http://127.0.0.1:38956/solr","node_name":"127.0.0.1:38956_solr","state":"active","type":"NRT","leader":"true"}
   [junit4]   2> 1594544 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(.system//collections/.system/state.json/3)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           "core":".system_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:38956/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:38956_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 1594545 INFO  (qtp6055505-8518) [n:127.0.0.1:38956_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1619
   [junit4]   2> 1594547 INFO  (qtp1314610907-8517) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1594588 INFO  
(OverseerCollectionConfigSetProcessor-72174931249397766-127.0.0.1:34678_solr-n_0000000000)
 [n:127.0.0.1:34678_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1594645 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 3
   [junit4]   2> 1594645 INFO  
(zkCallback-1838-thread-1-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1594645 INFO  
(zkCallback-1838-thread-2-processing-n:127.0.0.1:38956_solr) 
[n:127.0.0.1:38956_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/.system/state.json] for collection [.system] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1594856 DEBUG (ScheduledTrigger-3496-thread-1) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 1595548 INFO  (qtp1314610907-8517) [n:127.0.0.1:34678_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:38956_solr&wt=javabin&version=2}
 status=0 QTime=3078
   [junit4]   2> 1595550 INFO  (qtp1314610907-8521) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=3&maxShardsPerNode=3&name=AutoscalingHistoryHandlerTest_collection&nrtReplicas=3&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34678_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1595551 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 1595552 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 1595554 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 1595556 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 1595579 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 1595581 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 1595598 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 1595599 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_it.txt
   [junit4]   2> 1595601 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_no.txt
   [junit4]   2> 1595614 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hy.txt
   [junit4]   2> 1595615 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stemdict_nl.txt
   [junit4]   2> 1595616 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ca.txt
   [junit4]   2> 1595617 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_id.txt
   [junit4]   2> 1595635 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ga.txt
   [junit4]   2> 1595636 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_da.txt
   [junit4]   2> 1595637 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hi.txt
   [junit4]   2> 1595652 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ja.txt
   [junit4]   2> 1595654 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_pt.txt
   [junit4]   2> 1595671 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hu.txt
   [junit4]   2> 1595672 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_el.txt
   [junit4]   2> 1595673 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ru.txt
   [junit4]   2> 1595674 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_tr.txt
   [junit4]   2> 1595690 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ar.txt
   [junit4]   2> 1595711 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/userdict_ja.txt
   [junit4]   2> 1595724 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_it.txt
   [junit4]   2> 1595726 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_eu.txt
   [junit4]   2> 1595727 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_cz.txt
   [junit4]   2> 1595744 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stoptags_ja.txt
   [junit4]   2> 1595746 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_fr.txt
   [junit4]   2> 1595747 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fa.txt
   [junit4]   2> 1595763 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_de.txt
   [junit4]   2> 1595790 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ga.txt
   [junit4]   2> 1595841 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ca.txt
   [junit4]   2> 1595855 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_nl.txt
   [junit4]   2> 1595856 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_bg.txt
   [junit4]   2> 1595856 DEBUG (ScheduledTrigger-3496-thread-1) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 1595874 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_es.txt
   [junit4]   2> 1595875 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_en.txt
   [junit4]   2> 1595876 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_lv.txt
   [junit4]   2> 1595886 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_th.txt
   [junit4]   2> 1595887 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ro.txt
   [junit4]   2> 1595889 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fr.txt
   [junit4]   2> 1595898 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_sv.txt
   [junit4]   2> 1595900 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fi.txt
   [junit4]   2> 1595901 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/hyphenations_ga.txt
   [junit4]   2> 1595914 INFO  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_gl.txt
   [junit4]   2> 1595928 WARN  
(OverseerThreadFactory-3499-thread-2-processing-n:127.0.0.1:34678_solr) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.a.c.CreateCollectionCmd Specified number 
of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is 
higher than the number of Solr instances currently live or live and part of 
your createNodeSet(1). It's unusual to run two replica of the same slice on the 
same Solr-instance.
   [junit4]   2> 1595955 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "createNodeSet":"127.0.0.1:34678_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 1595956 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 1596056 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 1596159 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1596159 INFO  
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1596160 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 1596160 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1596161 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1596161 INFO  
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1596171 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1596171 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1596172 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1596172 INFO  
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1596173 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1596173 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node6":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>       "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1596273 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 1596383 INFO  (qtp1314610907-8527) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1596383 INFO  (qtp1314610907-8527) [n:127.0.0.1:34678_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1596384 INFO  (qtp1314610907-8523) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1596388 INFO  (qtp1314610907-8529) [n:127.0.0.1:34678_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1596418 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1596418 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1596418 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node3:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1","base_url":"http://127.0.0.1:34678/solr","node_name":"127.0.0.1:34678_solr","state":"down","type":"NRT"}
   [junit4]   2> 1596418 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1596419 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1596419 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1596419 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4","base_url":"http://127.0.0.1:34678/solr","node_name":"127.0.0.1:34678_solr","state":"down","type":"NRT"}
   [junit4]   2> 1596419 DEBUG 
(OverseerStateUpdate-72174931249397766-127.0.0.1:34678_solr-n_0000000000) 
[n:127.0.0.1:34678_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"http://127.0.0.1:34678/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:34678_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1596419 DEBUG (Ove

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

LABLE}
   [junit4]   2> 2835997 INFO  (jetty-closer-3156-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 2836052 INFO  (coreCloseExecutor-5795-thread-5) 
[n:127.0.0.1:36812_solr c:testSimple1 s:shard1 r:core_node12 
x:testSimple1_shard1_replica_n11] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testSimple1.shard1.replica_n11, tag=995605489
   [junit4]   2> 2836052 INFO  (coreCloseExecutor-5795-thread-5) 
[n:127.0.0.1:36812_solr c:testSimple1 s:shard1 r:core_node12 
x:testSimple1_shard1_replica_n11] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@fb0e249: rootName = 
solr_36812, domain = solr.core.testSimple1.shard1.replica_n11, service url = 
null, agent id = null] for registry solr.core.testSimple1.shard1.replica_n11 / 
com.codahale.metrics.MetricRegistry@7a9ab02b
   [junit4]   2> 2836072 INFO  (coreCloseExecutor-5795-thread-3) 
[n:127.0.0.1:36812_solr c:testSimple2 s:shard2 r:core_node7 
x:testSimple2_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testSimple2.shard2.replica_n4, tag=1721908839
   [junit4]   2> 2836072 INFO  (coreCloseExecutor-5795-thread-3) 
[n:127.0.0.1:36812_solr c:testSimple2 s:shard2 r:core_node7 
x:testSimple2_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6ffcf620: rootName = 
solr_36812, domain = solr.core.testSimple2.shard2.replica_n4, service url = 
null, agent id = null] for registry solr.core.testSimple2.shard2.replica_n4 / 
com.codahale.metrics.MetricRegistry@70a178f6
   [junit4]   2> 2836128 INFO  (coreCloseExecutor-5795-thread-3) 
[n:127.0.0.1:36812_solr c:testSimple2 s:shard2 r:core_node7 
x:testSimple2_shard2_replica_n4] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSimple2.shard2.leader, tag=1721908839
   [junit4]   2> 2836137 INFO  (coreCloseExecutor-5795-thread-1) 
[n:127.0.0.1:36812_solr c:testSimple1 s:shard2 r:core_node8 
x:testSimple1_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSimple1.shard2.leader, tag=2063116462
   [junit4]   2> 2836149 INFO  (coreCloseExecutor-5795-thread-4) 
[n:127.0.0.1:36812_solr c:testSimple2 s:shard1 r:core_node3 
x:testSimple2_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSimple2.shard1.leader, tag=635451932
   [junit4]   2> 2836151 INFO  (coreCloseExecutor-5795-thread-5) 
[n:127.0.0.1:36812_solr c:testSimple1 s:shard1 r:core_node12 
x:testSimple1_shard1_replica_n11] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSimple1.shard1.leader, tag=995605489
   [junit4]   2> 2836231 INFO  (jetty-closer-3156-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=72175003235057672-127.0.0.1:36812_solr-n_0000000001) closing
   [junit4]   2> 2836231 INFO  
(OverseerStateUpdate-72175003235057672-127.0.0.1:36812_solr-n_0000000001) 
[n:127.0.0.1:36812_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:36812_solr
   [junit4]   2> 2836232 WARN  
(OverseerAutoScalingTriggerThread-72175003235057672-127.0.0.1:36812_solr-n_0000000001)
 [n:127.0.0.1:36812_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 2836268 DEBUG (jetty-closer-3156-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 2836308 INFO  (jetty-closer-3156-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5c905210{/solr,null,UNAVAILABLE}
   [junit4]   2> 2836308 INFO  (jetty-closer-3156-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 2836361 ERROR 
(SUITE-AutoAddReplicasIntegrationTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2836361 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[16955A36D998FE70]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33107 33107
   [junit4]   2> 2836565 INFO  (Thread-3410) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:33107 33107
   [junit4]   2> 2836566 WARN  (Thread-3410) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        8       /solr/collections/testSimple1/terms/shard2
   [junit4]   2>        6       /solr/collections/testSimple1/terms/shard1
   [junit4]   2>        5       /solr/collections/testSimple2/terms/shard2
   [junit4]   2>        5       /solr/collections/testSimple2/terms/shard1
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2>        4       /solr/configs/conf
   [junit4]   2>        3       /solr/collections/testSimple3/terms/shard3
   [junit4]   2>        3       /solr/collections/testSimple3/terms/shard2
   [junit4]   2>        3       /solr/collections/testSimple3/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        43      /solr/collections/testSimple1/state.json
   [junit4]   2>        17      /solr/collections/testSimple2/state.json
   [junit4]   2>        17      /solr/collections/testSimple3/state.json
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        4       /solr/clusterprops.json
   [junit4]   2>        2       
/solr/collections/testSimple1/leader_elect/shard2/election/72175003235057672-core_node8-n_0000000000
   [junit4]   2>        2       
/solr/collections/testSimple1/leader_elect/shard1/election/72175003235057672-core_node5-n_0000000000
   [junit4]   2>        2       /solr/autoscaling.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72175003235057672-127.0.0.1:36812_solr-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2>        2       /solr/overseer/queue
   [junit4]   2>        2       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        2       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_16955A36D998FE70-001
   [junit4]   2> Feb 24, 2018 6:37:48 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=false): {}, locale=sr-Latn, 
timezone=Europe/Simferopol
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_152 (64-bit)/cpus=4,threads=1,free=158806112,total=521142272
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestPerFieldSimilarityWithDefaultOverride, TestCoreBackup, 
TestNoOpRegenerator, TestXIncludeConfig, TestCloudPivotFacet, 
DistributedFacetSimpleRefinementLongTailTest, TestSolrFieldCacheBean, 
TestUseDocValuesAsStored, TestSizeLimitedDistributedMap, SoftAutoCommitTest, 
BlockCacheTest, MoveReplicaHDFSFailoverTest, TestPivotHelperCode, 
NodeLostTriggerTest, TestExportWriter, ZkStateReaderTest, TestSmileRequest, 
CollectionStateFormat2Test, LargeFieldTest, TestRTGBase, TestFunctionQuery, 
TestPerFieldSimilarity, TestReplicationHandler, TestDistribIDF, 
TestSQLHandlerNonCloud, TestFieldSortValues, TestPullReplica, 
LoggingHandlerTest, TestCloudSearcherWarming, TestBulkSchemaConcurrent, 
HighlighterMaxOffsetTest, RequiredFieldsTest, TestQueryUtils, 
TestStressInPlaceUpdates, CollectionsAPIDistributedZkTest, 
TestJavabinTupleStreamParser, SearchHandlerTest, TestReloadAndDeleteDocs, 
TestCollectionAPI, SyncSliceTest, TestFieldResource, ComputePlanActionTest, 
TestDownShardTolerantSearch, TestNamedUpdateProcessors, 
FieldMutatingUpdateProcessorTest, FastVectorHighlighterTest, OverseerTest, 
UpdateRequestProcessorFactoryTest, TestSolrIndexConfig, PrimitiveFieldTypeTest, 
JsonLoaderTest, TestCursorMarkWithoutUniqueKey, DeleteNodeTest, JvmMetricsTest, 
DocExpirationUpdateProcessorFactoryTest, AutoscalingHistoryHandlerTest, 
TestReversedWildcardFilterFactory, TestElisionMultitermQuery, TestLegacyField, 
TestClassicSimilarityFactory, TestMinMaxOnMultiValuedField, 
DistribJoinFromCollectionTest, TestJsonRequest, CreateRoutedAliasTest, 
CdcrUpdateLogTest, HdfsChaosMonkeySafeLeaderTest, ReplaceNodeNoTargetTest, 
XsltUpdateRequestHandlerTest, LegacyCloudClusterPropTest, 
TestLocalFSCloudBackupRestore, TestRandomRequestDistribution, 
OverseerRolesTest, TestNestedDocsSort, TlogReplayBufferedWhileIndexingTest, 
TestSystemCollAutoCreate, TestRuleBasedAuthorizationPlugin, BadCopyFieldTest, 
PrimUtilsTest, TestReqParamsAPI, TestDynamicFieldCollectionResource, 
TestSolrCLIRunExample, TestTrieFacet, HdfsDirectoryTest, AnalyticsQueryTest, 
SaslZkACLProviderTest, SampleTest, TestConfigSets, 
TestConfigSetsAPIExclusivity, BlockJoinFacetSimpleTest, 
HdfsCollectionsAPIDistributedZkTest, QueryParsingTest, 
TestFieldCacheSortRandom, TestMiniSolrCloudClusterSSL, CoreSorterTest, 
TestRawTransformer, SolrShardReporterTest, 
DistributedQueryComponentOptimizationTest, AtomicUpdateProcessorFactoryTest, 
BasicFunctionalityTest, ZkFailoverTest, UUIDUpdateProcessorFallbackTest, 
IndexSchemaTest, SolrInfoBeanTest, TestSolrJ, TestFastLRUCache, 
ResourceLoaderTest, PathHierarchyTokenizerFactoryTest, StatsReloadRaceTest, 
TestStressRecovery, AddReplicaTest, TestNodeLostTrigger, 
AsyncCallRequestStatusResponseTest, MultiThreadedOCPTest, MetricUtilsTest, 
SortSpecParsingTest, HighlighterTest, SOLR749Test, DOMUtilTest, 
UninvertDocValuesMergePolicyTest, TestConfigOverlay, TestFoldingMultitermQuery, 
UpdateLogTest, AutoAddReplicasIntegrationTest]
   [junit4] Completed [339/777 (4!)] on J1 in 147.90s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 49995 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to