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

2 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple

Error Message:
Waiting for collection testSimple1 null Live Nodes: [127.0.0.1:34647_solr, 
127.0.0.1:55413_solr] Last available state: 
DocCollection(testSimple1//collections/testSimple1/state.json/15)={   
"pullReplicas":"0",   "replicationFactor":"2",   "shards":{     "shard1":{      
 "range":"80000000-ffffffff",       "state":"active",       "replicas":{        
 "core_node5":{           "core":"testSimple1_shard1_replica_n2",           
"base_url":"https://127.0.0.1:34647/solr";,           
"node_name":"127.0.0.1:34647_solr",           "state":"active",           
"type":"NRT",           "leader":"true"},         "core_node12":{           
"core":"testSimple1_shard1_replica_n11",           
"base_url":"https://127.0.0.1:34647/solr";,           
"node_name":"127.0.0.1:34647_solr",           "state":"active",           
"type":"NRT"}}},     "shard2":{       "range":"0-7fffffff",       
"state":"active",       "replicas":{         "core_node8":{           
"core":"testSimple1_shard2_replica_n6",           
"base_url":"https://127.0.0.1:34647/solr";,           
"node_name":"127.0.0.1:34647_solr",           "state":"active",           
"type":"NRT",           "leader":"true"},         "core_node10":{           
"core":"testSimple1_shard2_replica_n9",           
"base_url":"https://127.0.0.1:48729/solr";,           
"node_name":"127.0.0.1:48729_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:34647_solr, 127.0.0.1:55413_solr]
Last available state: 
DocCollection(testSimple1//collections/testSimple1/state.json/15)={
  "pullReplicas":"0",
  "replicationFactor":"2",
  "shards":{
    "shard1":{
      "range":"80000000-ffffffff",
      "state":"active",
      "replicas":{
        "core_node5":{
          "core":"testSimple1_shard1_replica_n2",
          "base_url":"https://127.0.0.1:34647/solr";,
          "node_name":"127.0.0.1:34647_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"},
        "core_node12":{
          "core":"testSimple1_shard1_replica_n11",
          "base_url":"https://127.0.0.1:34647/solr";,
          "node_name":"127.0.0.1:34647_solr",
          "state":"active",
          "type":"NRT"}}},
    "shard2":{
      "range":"0-7fffffff",
      "state":"active",
      "replicas":{
        "core_node8":{
          "core":"testSimple1_shard2_replica_n6",
          "base_url":"https://127.0.0.1:34647/solr";,
          "node_name":"127.0.0.1:34647_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"},
        "core_node10":{
          "core":"testSimple1_shard2_replica_n9",
          "base_url":"https://127.0.0.1:48729/solr";,
          "node_name":"127.0.0.1:48729_solr",
          "state":"down",
          "type":"NRT"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"2",
  "autoAddReplicas":"true",
  "nrtReplicas":"2",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([CA47FAA2EF1C521B:F2F4DE5CC8EF86CA]: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)


FAILED:  
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeWithMultipleReplicasLost

Error Message:
The operations computed by ComputePlanAction should not be null 
SolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan, null], 
BEFORE_ACTION=[compute_plan, null]}

Stack Trace:
java.lang.AssertionError: The operations computed by ComputePlanAction should 
not be null SolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan, 
null], BEFORE_ACTION=[compute_plan, null]}
        at 
__randomizedtesting.SeedInfo.seed([CA47FAA2EF1C521B:FA871B20676EB347]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeWithMultipleReplicasLost(ComputePlanActionTest.java:291)
        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 13168 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
   [junit4]   2> 1052759 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/init-core-data-001
   [junit4]   2> 1052759 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1052760 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1052761 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001
   [junit4]   2> 1052761 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1052761 INFO  (Thread-1748) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1052761 INFO  (Thread-1748) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1052767 ERROR (Thread-1748) [    ] 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> 1052861 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:57795
   [junit4]   2> 1052863 INFO  (zkConnectionManagerCallback-1689-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1052869 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1052869 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1052869 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1052869 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1052870 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7bc10753{/solr,null,AVAILABLE}
   [junit4]   2> 1052870 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4454ef40{SSL,[ssl, 
http/1.1]}{127.0.0.1:57003}
   [junit4]   2> 1052870 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.e.j.s.Server Started @1054892ms
   [junit4]   2> 1052870 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=57003}
   [junit4]   2> 1052871 ERROR (jetty-launcher-1686-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1052871 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 1052871 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1052871 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1052871 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-14T15:04:29.057Z
   [junit4]   2> 1052872 INFO  (zkConnectionManagerCallback-1691-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1052872 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1052879 INFO  (jetty-launcher-1686-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57795/solr
   [junit4]   2> 1052880 INFO  (zkConnectionManagerCallback-1695-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1052881 INFO  
(zkConnectionManagerCallback-1697-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1052949 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1052950 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:57003_solr
   [junit4]   2> 1052950 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer Overseer 
(id=73294427248787459-127.0.0.1:57003_solr-n_0000000000) starting
   [junit4]   2> 1052956 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1052965 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:57003_solr
   [junit4]   2> 1052965 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 1052970 INFO  
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1052971 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 1052971 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:57003_solr]
   [junit4]   2> 1052971 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 1052971 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 1052973 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1052973 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1052973 DEBUG (ScheduledTrigger-3245-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1053081 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57003.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053099 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57003.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053099 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57003.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053100 INFO  (jetty-launcher-1686-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node1/.
   [junit4]   2> 1053115 INFO  (zkConnectionManagerCallback-1701-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053119 INFO  (zkConnectionManagerCallback-1705-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053120 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1053120 INFO  
(SUITE-ComputePlanActionTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57795/solr ready
   [junit4]   2> 1053134 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.SolrTestCaseJ4 ###Starting testSelectedCollections
   [junit4]   2> 1053135 DEBUG 
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 2
   [junit4]   2> 1053135 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 2
   [junit4]   2> 1053136 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1053136 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 1053136 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1053136 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1053172 INFO  (qtp93794127-8860) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053173 DEBUG (qtp93794127-8856) [n:127.0.0.1:57003_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1053173 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 1053173 DEBUG 
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 3
   [junit4]   2> 1053173 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 3
   [junit4]   2> 1053173 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 1053173 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1053174 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 3, lastZnodeVersion 3
   [junit4]   2> 1053176 INFO  (qtp93794127-8859) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053177 DEBUG (qtp93794127-8858) [n:127.0.0.1:57003_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1053177 INFO  (qtp93794127-8858) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1053177 DEBUG 
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 4
   [junit4]   2> 1053177 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 4
   [junit4]   2> 1053177 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeLost markers
   [junit4]   2> 1053178 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1053178 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 4, lastZnodeVersion 4
   [junit4]   2> 1053180 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1053181 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1053181 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1053181 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1053181 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@35ee988a{/solr,null,AVAILABLE}
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.AbstractConnector Started ServerConnector@6f1b939b{SSL,[ssl, 
http/1.1]}{127.0.0.1:44338}
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server Started @1055203ms
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44338}
   [junit4]   2> 1053182 ERROR 
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 7.3.0
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port 
null
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1053182 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-14T15:04:29.368Z
   [junit4]   2> 1053184 INFO  (zkConnectionManagerCallback-1708-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053184 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1053191 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57795/solr
   [junit4]   2> 1053192 INFO  (zkConnectionManagerCallback-1712-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053194 INFO  
(zkConnectionManagerCallback-1714-thread-1-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053199 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1053201 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1053203 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44338_solr
   [junit4]   2> 1053203 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:44338_solr"} current state version: 0
   [junit4]   2> 1053203 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:44338_solr
   [junit4]   2> 1053204 INFO  
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1053213 INFO  
(zkCallback-1713-thread-1-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1053213 INFO  (zkCallback-1704-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1053213 INFO  (zkCallback-1704-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1053268 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44338.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053277 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44338.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053277 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44338.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053278 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node2/.
   [junit4]   2> 1053305 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1053312 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1053312 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1053312 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 1053312 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@33fbbf8c{/solr,null,AVAILABLE}
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.AbstractConnector Started ServerConnector@1f2b8b21{SSL,[ssl, 
http/1.1]}{127.0.0.1:46513}
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server Started @1055334ms
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=46513}
   [junit4]   2> 1053313 ERROR 
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 7.3.0
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port 
null
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1053313 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-14T15:04:29.499Z
   [junit4]   2> 1053317 INFO  (zkConnectionManagerCallback-1718-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053317 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1053325 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57795/solr
   [junit4]   2> 1053326 INFO  (zkConnectionManagerCallback-1722-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053328 INFO  
(zkConnectionManagerCallback-1724-thread-1-processing-n:127.0.0.1:46513_solr) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053331 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1053332 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1053333 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:46513_solr"} current state version: 0
   [junit4]   2> 1053333 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:46513_solr
   [junit4]   2> 1053333 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46513_solr
   [junit4]   2> 1053334 INFO  
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1053345 INFO  
(zkCallback-1723-thread-1-processing-n:127.0.0.1:46513_solr) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1053345 INFO  (zkCallback-1704-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1053345 INFO  
(zkCallback-1713-thread-1-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 1053346 INFO  (zkCallback-1704-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1053392 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46513.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053402 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46513.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053402 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46513.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053403 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node3/.
   [junit4]   2> 1053439 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1053440 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1053440 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1053441 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1053441 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@50c2f298{/solr,null,AVAILABLE}
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.AbstractConnector Started ServerConnector@3dca6c26{SSL,[ssl, 
http/1.1]}{127.0.0.1:49153}
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.e.j.s.Server Started @1055463ms
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=49153}
   [junit4]   2> 1053442 ERROR 
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 7.3.0
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port 
null
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1053442 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-14T15:04:29.628Z
   [junit4]   2> 1053444 INFO  (zkConnectionManagerCallback-1728-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053444 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1053452 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) [  
  ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57795/solr
   [junit4]   2> 1053453 INFO  (zkConnectionManagerCallback-1732-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053455 INFO  
(zkConnectionManagerCallback-1734-thread-1-processing-n:127.0.0.1:49153_solr) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053460 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 1053461 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1053463 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:49153_solr
   [junit4]   2> 1053463 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:49153_solr"} current state version: 0
   [junit4]   2> 1053463 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:49153_solr
   [junit4]   2> 1053464 INFO  
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1053464 INFO  
(zkCallback-1733-thread-1-processing-n:127.0.0.1:49153_solr) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1053472 INFO  
(zkCallback-1723-thread-1-processing-n:127.0.0.1:46513_solr) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1053472 INFO  
(zkCallback-1713-thread-1-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 1053473 INFO  (zkCallback-1704-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1053473 INFO  (zkCallback-1704-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1053531 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49153.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053551 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49153.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053551 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49153.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1053552 INFO  
(TEST-ComputePlanActionTest.testSelectedCollections-seed#[CA47FAA2EF1C521B]) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node4/.
   [junit4]   2> 1053599 INFO  (zkConnectionManagerCallback-1738-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1053641 INFO  (qtp384203210-8892) [n:127.0.0.1:44338_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053667 INFO  (qtp1368986872-8919) [n:127.0.0.1:46513_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053694 INFO  (qtp753423731-8943) [n:127.0.0.1:49153_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053697 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053697 DEBUG (qtp384203210-8894) [n:127.0.0.1:44338_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1053697 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=74
   [junit4]   2> 1053698 DEBUG 
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 5
   [junit4]   2> 1053698 INFO  (qtp384203210-8893) [n:127.0.0.1:44338_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=testSelected1&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1053698 DEBUG 
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:46513_solr, 127.0.0.1:44338_solr, 127.0.0.1:57003_solr, 
127.0.0.1:49153_solr]
   [junit4]   2> 1053698 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 5
   [junit4]   2> 1053700 INFO  
(OverseerThreadFactory-3247-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
testSelected1
   [junit4]   2> 1053700 DEBUG (ScheduledTrigger-3245-thread-1) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
node_lost_trigger with currently live nodes: 4
   [junit4]   2> 1053703 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053707 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1053708 DEBUG 
(OverseerAutoScalingTriggerThread-73294427248787459-127.0.0.1:57003_solr-n_0000000000)
 [n:127.0.0.1:57003_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 5, lastZnodeVersion 5
   [junit4]   2> 1053709 INFO  (qtp1368986872-8919) [n:127.0.0.1:46513_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053712 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053713 INFO  (qtp93794127-8860) [n:127.0.0.1:57003_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1053715 INFO  
(OverseerThreadFactory-3247-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.s.c.a.PolicyHelper returnSession, 
curr-time 18872578023 sessionWrapper.createTime 18872578021864029, 
this.sessionWrapper.createTime 18872578021864029 
   [junit4]   2> 1053719 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":"testSelected1",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "collection.configName":"conf",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 1053719 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: testSelected1
   [junit4]   2> 1053719 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/testSelected1/state.json
   [junit4]   2> 1053821 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1053821 INFO  
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1053822 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 1053822 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053823 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1053823 INFO  
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1053824 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053824 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-ffffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053825 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1053825 INFO  
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1053826 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 1053826 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator New Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053827 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 1053827 INFO  
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1053828 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053828 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.SliceMutator New Slice: shard2:{
   [junit4]   2>   "range":"0-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node7":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>       "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node8":{
   [junit4]   2>       "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>       "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 1053928 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/testSelected1/state.json version: 0
   [junit4]   2> 1054032 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSelected1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSelected1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1054032 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1054033 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSelected1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSelected1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1054033 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1054033 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSelected1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSelected1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1054033 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1054034 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSelected1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSelected1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1054034 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node5:{"core":"testSelected1_shard1_replica_n2","base_url":"https://127.0.0.1:49153/solr","node_name":"127.0.0.1:49153_solr","state":"down","type":"NRT"}
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46513_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>   "core_node_name":"core_node7",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:46513_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node7:{"core":"testSelected1_shard2_replica_n4","base_url":"https://127.0.0.1:46513/solr","node_name":"127.0.0.1:46513_solr","state":"down","type":"NRT"}
   [junit4]   2> 1054042 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:46513_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1054043 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:57003_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1054043 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:57003_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1054043 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node3:{"core":"testSelected1_shard1_replica_n1","base_url":"https://127.0.0.1:57003/solr","node_name":"127.0.0.1:57003_solr","state":"down","type":"NRT"}
   [junit4]   2> 1054043 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:57003_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:46513_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1054044 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.Overseer processMessage: queueSize: 4, 
message = {
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44338_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1054044 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>   "core_node_name":"core_node8",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44338_solr",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "collection":"testSelected1",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1054044 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node8:{"core":"testSelected1_shard2_replica_n6","base_url":"https://127.0.0.1:44338/solr","node_name":"127.0.0.1:44338_solr","state":"down","type":"NRT"}
   [junit4]   2> 1054044 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ReplicaMutator Collection is now: 
DocCollection(testSelected1//collections/testSelected1/state.json/1)={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"2",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{
   [junit4]   2>     "shard1":{
   [junit4]   2>       "range":"80000000-ffffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:57003/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:57003_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"testSelected1_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:49153/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:49153_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}},
   [junit4]   2>     "shard2":{
   [junit4]   2>       "range":"0-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node7":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:46513/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:46513_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node8":{
   [junit4]   2>           "core":"testSelected1_shard2_replica_n6",
   [junit4]   2>           "base_url":"https://127.0.0.1:44338/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:44338_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 1054145 DEBUG 
(OverseerStateUpdate-73294427248787459-127.0.0.1:57003_solr-n_0000000000) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/testSelected1/state.json version: 1
   [junit4]   2> 1054145 INFO  
(zkCallback-1696-thread-1-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054145 INFO  
(zkCallback-1713-thread-1-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054145 INFO  
(zkCallback-1733-thread-1-processing-n:127.0.0.1:49153_solr) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054145 INFO  
(zkCallback-1723-thread-1-processing-n:127.0.0.1:46513_solr) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054146 INFO  
(zkCallback-1733-thread-2-processing-n:127.0.0.1:49153_solr) 
[n:127.0.0.1:49153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054146 INFO  
(zkCallback-1723-thread-2-processing-n:127.0.0.1:46513_solr) 
[n:127.0.0.1:46513_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054146 INFO  
(zkCallback-1696-thread-2-processing-n:127.0.0.1:57003_solr) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054146 INFO  
(zkCallback-1713-thread-2-processing-n:127.0.0.1:44338_solr) 
[n:127.0.0.1:44338_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/testSelected1/state.json] for collection [testSelected1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 1054702 DEBUG (ScheduledTrigger-3245-thread-3) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
node_lost_trigger with currently live nodes: 4
   [junit4]   2> 1055052 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1055053 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1055053 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1055059 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.s.IndexSchema [testSelected1_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1055059 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.s.IndexSchema [testSelected1_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 1055060 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 1055752 DEBUG (ScheduledTrigger-3245-thread-3) 
[n:127.0.0.1:57003_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
node_lost_trigger with currently live nodes: 4
   [junit4]   2> 1055755 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1055755 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.c.CoreContainer Creating SolrCore 'testSelected1_shard2_replica_n6' using 
configuration from collection testSelected1, trusted=true
   [junit4]   2> 1055756 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1055757 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.c.CoreContainer Creating SolrCore 'testSelected1_shard2_replica_n4' using 
configuration from collection testSelected1, trusted=true
   [junit4]   2> 1055757 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_46513.solr.core.testSelected1.shard2.replica_n4' (registry 
'solr.core.testSelected1.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1055757 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44338.solr.core.testSelected1.shard2.replica_n6' (registry 
'solr.core.testSelected1.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1055758 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1055758 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1055758 INFO  (qtp384203210-8894) [n:127.0.0.1:44338_solr 
c:testSelected1 s:shard2 r:core_node8 x:testSelected1_shard2_replica_n6] 
o.a.s.c.SolrCore [[testSelected1_shard2_replica_n6] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node2/testSelected1_shard2_replica_n6],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node2/./testSelected1_shard2_replica_n6/data/]
   [junit4]   2> 1055759 INFO  (qtp1368986872-8921) [n:127.0.0.1:46513_solr 
c:testSelected1 s:shard2 r:core_node7 x:testSelected1_shard2_replica_n4] 
o.a.s.c.SolrCore [[testSelected1_shard2_replica_n4] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node3/testSelected1_shard2_replica_n4],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node3/./testSelected1_shard2_replica_n4/data/]
   [junit4]   2> 1055763 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.s.IndexSchema [testSelected1_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1055763 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.s.IndexSchema [testSelected1_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1055765 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1055765 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'testSelected1_shard1_replica_n1' using 
configuration from collection testSelected1, trusted=true
   [junit4]   2> 1055765 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1055765 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'testSelected1_shard1_replica_n2' using 
configuration from collection testSelected1, trusted=true
   [junit4]   2> 1055765 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57003.solr.core.testSelected1.shard1.replica_n1' (registry 
'solr.core.testSelected1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1055766 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1055768 INFO  (qtp93794127-8856) [n:127.0.0.1:57003_solr 
c:testSelected1 s:shard1 r:core_node3 x:testSelected1_shard1_replica_n1] 
o.a.s.c.SolrCore [[testSelected1_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node1/testSelected1_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_CA47FAA2EF1C521B-001/tempDir-001/node1/./testSelected1_shard1_replica_n1/data/]
   [junit4]   2> 1055770 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_49153.solr.core.testSelected1.shard1.replica_n2' (registry 
'solr.core.testSelected1.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@387b4f98
   [junit4]   2> 1055770 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1055770 INFO  (qtp753423731-8946) [n:127.0.0.1:49153_solr 
c:testSelected1 s:shard1 r:core_node5 x:testSelected1_shard1_replica_n2] 
o.a.s.c.SolrCore [[testSelected1_shard1_replica_n2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/

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

, tag=157420892
   [junit4]   2> 2686610 INFO  (coreCloseExecutor-7616-thread-4) 
[n:127.0.0.1:34647_solr c:testSimple2 s:shard2 r:core_node8 
x:testSimple2_shard2_replica_n7] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@20697b99: rootName = 
solr_34647, domain = solr.core.testSimple2.shard2.replica_n7, service url = 
null, agent id = null] for registry solr.core.testSimple2.shard2.replica_n7 / 
com.codahale.metrics.MetricRegistry@15447d07
   [junit4]   2> 2686619 INFO  (coreCloseExecutor-7616-thread-4) 
[n:127.0.0.1:34647_solr c:testSimple2 s:shard2 r:core_node8 
x:testSimple2_shard2_replica_n7] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSimple2.shard2.leader, tag=157420892
   [junit4]   2> 2686620 INFO  (coreCloseExecutor-7616-thread-5) 
[n:127.0.0.1:34647_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=1635997036
   [junit4]   2> 2686620 INFO  (coreCloseExecutor-7616-thread-5) 
[n:127.0.0.1:34647_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@2c181357: rootName = 
solr_34647, 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@1f6d763
   [junit4]   2> 2686629 INFO  (coreCloseExecutor-7616-thread-5) 
[n:127.0.0.1:34647_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=1635997036
   [junit4]   2> 2686629 INFO  (coreCloseExecutor-7616-thread-1) 
[n:127.0.0.1:34647_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=369221715
   [junit4]   2> 2686630 INFO  (jetty-closer-8345-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=73294525102751751-127.0.0.1:34647_solr-n_0000000002) closing
   [junit4]   2> 2686630 INFO  
(OverseerStateUpdate-73294525102751751-127.0.0.1:34647_solr-n_0000000002) 
[n:127.0.0.1:34647_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:34647_solr
   [junit4]   2> 2686630 WARN  
(OverseerAutoScalingTriggerThread-73294525102751751-127.0.0.1:34647_solr-n_0000000002)
 [n:127.0.0.1:34647_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 2686633 DEBUG (jetty-closer-8345-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 2686634 INFO  (jetty-closer-8345-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7c3ba3d5{/solr,null,UNAVAILABLE}
   [junit4]   2> 2686637 INFO  (jetty-closer-8345-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 2686637 ERROR 
(SUITE-AutoAddReplicasIntegrationTest-seed#[CA47FAA2EF1C521B]-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> 2686638 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[CA47FAA2EF1C521B]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34022 34022
   [junit4]   2> 2686742 INFO  (Thread-6172) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34022 34022
   [junit4]   2> 2686745 WARN  (Thread-6172) [    ] 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/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>        33      /solr/collections/testSimple1/state.json
   [junit4]   2>        20      /solr/collections/testSimple2/state.json
   [junit4]   2>        13      /solr/collections/testSimple3/state.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        3       /solr/autoscaling.json
   [junit4]   2>        2       
/solr/collections/testSimple1/leader_elect/shard1/election/73294525102751751-core_node5-n_0000000000
   [junit4]   2>        2       
/solr/collections/testSimple1/leader_elect/shard2/election/73294525102751751-core_node8-n_0000000000
   [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>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_CA47FAA2EF1C521B-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=690, maxMBSortInHeap=6.0731850071594655, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ar, timezone=Pacific/Palau
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=1,free=113645360,total=518520832
   [junit4]   2> NOTE: All tests run in this JVM: [TestCorePropertiesReload, 
TestTolerantUpdateProcessorRandomCloud, ZkStateWriterTest, 
RestartWhileUpdatingTest, AddReplicaTest, CloneFieldUpdateProcessorFactoryTest, 
SliceStateTest, SystemInfoHandlerTest, TestRTimerTree, DOMUtilTest, 
FullHLLTest, TestFastLRUCache, TestFunctionQuery, LoggingHandlerTest, 
ConjunctionSolrSpellCheckerTest, TestCustomDocTransformer, 
LeaderFailoverAfterPartitionTest, OverseerTest, TestCloudSchemaless, 
TestSearchPerf, ResponseBuilderTest, RulesTest, OverseerRolesTest, SampleTest, 
PrimUtilsTest, TestFieldCacheSort, FileUtilsTest, TestImplicitCoreProperties, 
TestLargeCluster, SuggesterFSTTest, TestDocTermOrds, 
TestHighFrequencyDictionaryFactory, SolrInfoBeanTest, SparseHLLTest, 
TestFoldingMultitermQuery, CoreAdminRequestStatusTest, 
TestPayloadCheckQParserPlugin, DocValuesNotIndexedTest, 
AnalyticsMergeStrategyTest, TestLegacyNumericUtils, TestStreamBody, 
CSVRequestHandlerTest, TestStressVersions, CachingDirectoryFactoryTest, 
PathHierarchyTokenizerFactoryTest, ShufflingReplicaListTransformerTest, 
DeleteStatusTest, SolrCoreTest, ZkControllerTest, TermsComponentTest, 
AsyncCallRequestStatusResponseTest, TestCloudPivotFacet, CheckHdfsIndexTest, 
JavabinLoaderTest, BasicZkTest, TestPointFields, TestHttpShardHandlerFactory, 
TestCursorMarkWithoutUniqueKey, TestRecovery, TestReplicationHandlerBackup, 
TestCollectionAPIs, TestSchemaSimilarityResource, TestNumericRangeQuery32, 
TestStressUserVersions, AlternateDirectoryTest, TriLevelCompositeIdRoutingTest, 
TestStressLiveNodes, TestRandomCollapseQParserPlugin, TestSystemIdResolver, 
SaslZkACLProviderTest, ShardRoutingCustomTest, CursorMarkTest, 
DirectoryFactoryTest, UtilsToolTest, TestSQLHandler, StressHdfsTest, 
SubstringBytesRefFilterTest, TolerantUpdateProcessorTest, QueryParsingTest, 
TestNonDefinedSimilarityFactory, DirectSolrConnectionTest, V2StandaloneTest, 
TestFieldTypeResource, TestNRTOpen, TestCollectionsAPIViaSolrCloudCluster, 
TestZkChroot, DocumentBuilderTest, TestOnReconnectListenerSupport, 
DistributedMLTComponentTest, TestDistributedGrouping, DocValuesMissingTest, 
TestSubQueryTransformerCrossCore, TestSolrIndexConfig, TestMultiWordSynonyms, 
QueryElevationComponentTest, TestJettySolrRunner, BaseCdcrDistributedZkTest, 
SyncSliceTest, TestLegacyNumericRangeQueryBuilder, 
TestReversedWildcardFilterFactory, UpdateRequestProcessorFactoryTest, 
TestCopyFieldCollectionResource, ReplaceNodeNoTargetTest, 
TestReplicationHandler, TestSegmentSorting, BadComponentTest, 
BigEndianAscendingWordSerializerTest, TestFieldCacheWithThreads, 
TestPerFieldSimilarity, PeerSyncReplicationTest, 
TestExclusionRuleCollectionAccess, TestLeaderInitiatedRecoveryThread, 
TestFuzzyAnalyzedSuggestions, AutoAddReplicasPlanActionTest, 
TestSortByMinMaxFunction, SimplePostToolTest, TestRTGBase, ScriptEngineTest, 
BasicAuthStandaloneTest, TemplateUpdateProcessorTest, 
DistributedIntervalFacetingTest, TestSweetSpotSimilarityFactory, 
TestSurroundQueryParser, FieldMutatingUpdateProcessorTest, TestSolr4Spatial, 
SolrCloudReportersTest, TestSimpleTrackingShardHandler, BasicDistributedZkTest, 
ReplicationFactorTest, RollingRestartTest, SolrXmlInZkTest, 
TestCloudDeleteByQuery, TestCloudSearcherWarming, TestLeaderElectionZkExpiry, 
TestLockTree, TestMiniSolrCloudClusterSSL, TestPullReplicaErrorHandling, 
TestRandomFlRTGCloud, TestRequestForwarding, TestShortCircuitedRequests, 
TestSkipOverseerOperations, TestSolrCloudWithSecureImpersonation, 
TestTolerantUpdateProcessorCloud, TestUtilizeNode, 
TlogReplayBufferedWhileIndexingTest, VMParamsZkACLAndCredentialsProvidersTest, 
ZkShardTermsTest, AssignTest, CollectionReloadTest, 
CollectionTooManyReplicasTest, CollectionsAPIDistributedZkTest, 
TestCollectionAPI, TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore, 
TestReplicaProperties, TestRequestStatusCollectionAPI, 
AutoAddReplicasIntegrationTest]
   [junit4] Completed [575/775 (2!)] on J1 in 140.91s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to