Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20862/
Java: 64bit/jdk-10-ea+29 -XX:+UseCompressedOops -XX:+UseG1GC

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

Error Message:
Waiting for collection testSimple2 null Live Nodes: [127.0.0.1:35413_solr, 
127.0.0.1:43303_solr] Last available state: 
DocCollection(testSimple2//collections/testSimple2/state.json/15)={   
"pullReplicas":"0",   "replicationFactor":"2",   "shards":{     "shard1":{      
 "range":"80000000-ffffffff",       "state":"active",       "replicas":{        
 "core_node3":{           "core":"testSimple2_shard1_replica_n1",           
"base_url":"https://127.0.0.1:33497/solr";,           
"node_name":"127.0.0.1:33497_solr",           "state":"down",           
"type":"NRT"},         "core_node5":{           
"core":"testSimple2_shard1_replica_n2",           
"base_url":"https://127.0.0.1:43303/solr";,           
"node_name":"127.0.0.1:43303_solr",           "state":"active",           
"type":"NRT",           "leader":"true"}}},     "shard2":{       
"range":"0-7fffffff",       "state":"active",       "replicas":{         
"core_node7":{           "core":"testSimple2_shard2_replica_n4",           
"base_url":"https://127.0.0.1:33497/solr";,           
"node_name":"127.0.0.1:33497_solr",           "state":"down",           
"type":"NRT"},         "core_node8":{           
"core":"testSimple2_shard2_replica_n6",           
"base_url":"https://127.0.0.1:43303/solr";,           
"node_name":"127.0.0.1:43303_solr",           "state":"active",           
"type":"NRT",           "leader":"true"}}}},   "router":{"name":"compositeId"}, 
  "maxShardsPerNode":"2",   "autoAddReplicas":"true",   "nrtReplicas":"2",   
"tlogReplicas":"0"}

Stack Trace:
java.lang.AssertionError: Waiting for collection testSimple2
null
Live Nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr]
Last available state: 
DocCollection(testSimple2//collections/testSimple2/state.json/15)={
  "pullReplicas":"0",
  "replicationFactor":"2",
  "shards":{
    "shard1":{
      "range":"80000000-ffffffff",
      "state":"active",
      "replicas":{
        "core_node3":{
          "core":"testSimple2_shard1_replica_n1",
          "base_url":"https://127.0.0.1:33497/solr";,
          "node_name":"127.0.0.1:33497_solr",
          "state":"down",
          "type":"NRT"},
        "core_node5":{
          "core":"testSimple2_shard1_replica_n2",
          "base_url":"https://127.0.0.1:43303/solr";,
          "node_name":"127.0.0.1:43303_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"}}},
    "shard2":{
      "range":"0-7fffffff",
      "state":"active",
      "replicas":{
        "core_node7":{
          "core":"testSimple2_shard2_replica_n4",
          "base_url":"https://127.0.0.1:33497/solr";,
          "node_name":"127.0.0.1:33497_solr",
          "state":"down",
          "type":"NRT"},
        "core_node8":{
          "core":"testSimple2_shard2_replica_n6",
          "base_url":"https://127.0.0.1:43303/solr";,
          "node_name":"127.0.0.1:43303_solr",
          "state":"active",
          "type":"NRT",
          "leader":"true"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"2",
  "autoAddReplicas":"true",
  "nrtReplicas":"2",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([52E893DDAB0ACAEA:6A5BB7238CF91E3B]: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:125)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 13492 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/init-core-data-001
   [junit4]   2> 1980285 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1980285 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1980286 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1980286 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001
   [junit4]   2> 1980287 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1980287 INFO  (Thread-4329) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1980287 INFO  (Thread-4329) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1980290 ERROR (Thread-4329) [    ] 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> 1980387 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:38613
   [junit4]   2> 1980399 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1980399 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1980399 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 1980428 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3c835617{/solr,null,AVAILABLE}
   [junit4]   2> 1980435 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a468533{/solr,null,AVAILABLE}
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@49c1115e{SSL,[ssl, 
http/1.1]}{127.0.0.1:43303}
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.e.j.s.Server Started @1981842ms
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@43a08c72{/solr,null,AVAILABLE}
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@15f0bfae{SSL,[ssl, 
http/1.1]}{127.0.0.1:33497}
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.e.j.s.Server Started @1981843ms
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=33497}
   [junit4]   2> 1980436 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43303}
   [junit4]   2> 1980437 ERROR (jetty-launcher-5992-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1980437 ERROR (jetty-launcher-5992-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@3b0ad654{SSL,[ssl, 
http/1.1]}{127.0.0.1:35413}
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.e.j.s.Server Started @1981844ms
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=35413}
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-08T05:24:56.471434Z
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1980437 ERROR (jetty-launcher-5992-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-08T05:24:56.471735Z
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1980437 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-08T05:24:56.471894Z
   [junit4]   2> 1980448 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1980461 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1980462 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1980464 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38613/solr
   [junit4]   2> 1980472 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38613/solr
   [junit4]   2> 1980472 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38613/solr
   [junit4]   2> 1980473 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15f9a16a5830005, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 1980511 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1980511 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35413_solr
   [junit4]   2> 1980511 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98967138882224136-127.0.0.1:35413_solr-n_0000000000) starting
   [junit4]   2> 1980517 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35413_solr
   [junit4]   2> 1980517 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
   [junit4]   2> 1980520 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1980522 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1980523 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1980526 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33497_solr
   [junit4]   2> 1980520 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 1980533 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1980545 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:35413_solr]
   [junit4]   2> 1980545 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion -1
   [junit4]   2> 1980545 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 1980547 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1980547 INFO  (zkCallback-6008-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1980547 DEBUG 
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 1980553 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1980553 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1980557 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:33497_solr]
   [junit4]   2> 1980557 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43303_solr
   [junit4]   2> 1980571 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1980571 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1980576 INFO  (zkCallback-6007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1980581 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33497.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980596 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35413.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980598 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33497.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980607 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33497.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980609 INFO  (jetty-launcher-5992-thread-3) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/.
   [junit4]   2> 1980609 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35413.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980609 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35413.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980610 INFO  (jetty-launcher-5992-thread-1) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/.
   [junit4]   2> 1980642 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43303.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980655 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43303.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980655 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43303.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1980656 INFO  (jetty-launcher-5992-thread-2) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node2/.
   [junit4]   2> 1980771 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1980772 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:38613/solr ready
   [junit4]   2> 1980785 INFO  
(TEST-AutoAddReplicasIntegrationTest.testSimple-seed#[52E893DDAB0ACAEA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSimple
   [junit4]   2> 1980804 INFO  (qtp4998343-27886) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=true&name=testSimple1&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:35413_solr,127.0.0.1:33497_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1980808 INFO  (OverseerThreadFactory-8191-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection testSimple1
   [junit4]   2> 1980917 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSimple1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35413/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1980920 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSimple1_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33497/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1980921 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSimple1_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35413/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1980922 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSimple1_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33497/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1981163 INFO  (qtp4998343-27881) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1981164 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1981165 INFO  (qtp4998343-27861) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1981195 INFO  (qtp658178728-27862) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1981195 INFO  (qtp658178728-27862) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1981202 INFO  (qtp658178728-27865) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1981306 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1981306 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1981306 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1981557 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1982184 INFO  (qtp4998343-27881) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1982186 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1982190 INFO  (qtp4998343-27861) [    ] o.a.s.s.IndexSchema 
[testSimple1_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1982192 INFO  (qtp4998343-27861) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1982192 INFO  (qtp4998343-27861) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'testSimple1_shard1_replica_n1' using configuration from 
collection testSimple1, trusted=true
   [junit4]   2> 1982192 INFO  (qtp4998343-27861) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35413.solr.core.testSimple1.shard1.replica_n1' (registry 
'solr.core.testSimple1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1982192 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1982192 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrCore 
[[testSimple1_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/testSimple1_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/./testSimple1_shard1_replica_n1/data/]
   [junit4]   2> 1982200 INFO  (qtp4998343-27881) [    ] o.a.s.s.IndexSchema 
[testSimple1_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 1982201 INFO  (qtp4998343-27881) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1982201 INFO  (qtp4998343-27881) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'testSimple1_shard2_replica_n4' using configuration from 
collection testSimple1, trusted=true
   [junit4]   2> 1982202 INFO  (qtp4998343-27881) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35413.solr.core.testSimple1.shard2.replica_n4' (registry 
'solr.core.testSimple1.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1982202 INFO  (qtp4998343-27881) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1982203 INFO  (qtp4998343-27881) [    ] o.a.s.c.SolrCore 
[[testSimple1_shard2_replica_n4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/testSimple1_shard2_replica_n4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/./testSimple1_shard2_replica_n4/data/]
   [junit4]   2> 1982216 INFO  (qtp658178728-27862) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1982222 INFO  (qtp658178728-27862) [    ] o.a.s.s.IndexSchema 
[testSimple1_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1982223 INFO  (qtp658178728-27865) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1982223 INFO  (qtp658178728-27862) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1982223 INFO  (qtp658178728-27862) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard1_replica_n2' using 
configuration from collection testSimple1, trusted=true
   [junit4]   2> 1982251 INFO  (qtp658178728-27862) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33497.solr.core.testSimple1.shard1.replica_n2' (registry 
'solr.core.testSimple1.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1982251 INFO  (qtp658178728-27862) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1982251 INFO  (qtp658178728-27862) [    ] o.a.s.c.SolrCore 
[[testSimple1_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/testSimple1_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/./testSimple1_shard1_replica_n2/data/]
   [junit4]   2> 1982257 INFO  (qtp658178728-27865) [    ] o.a.s.s.IndexSchema 
[testSimple1_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1982259 INFO  (qtp658178728-27865) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1982259 INFO  (qtp658178728-27865) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard2_replica_n6' using 
configuration from collection testSimple1, trusted=true
   [junit4]   2> 1982261 INFO  (qtp658178728-27865) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33497.solr.core.testSimple1.shard2.replica_n6' (registry 
'solr.core.testSimple1.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1982261 INFO  (qtp658178728-27865) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1982261 INFO  (qtp658178728-27865) [    ] o.a.s.c.SolrCore 
[[testSimple1_shard2_replica_n6] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/testSimple1_shard2_replica_n6],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/./testSimple1_shard2_replica_n6/data/]
   [junit4]   2> 1982322 INFO  (qtp4998343-27861) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1982322 INFO  (qtp4998343-27861) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1982324 INFO  (qtp4998343-27861) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1982324 INFO  (qtp4998343-27861) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1982326 INFO  (qtp4998343-27861) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6a851641[testSimple1_shard1_replica_n1] main]
   [junit4]   2> 1982332 INFO  (qtp4998343-27861) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1982340 INFO  (qtp4998343-27861) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1982351 INFO  (qtp4998343-27861) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1982354 INFO  (qtp4998343-27881) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1982354 INFO  (qtp4998343-27881) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1982358 INFO  (qtp4998343-27881) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1982358 INFO  (qtp4998343-27881) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1982359 INFO  (qtp4998343-27881) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@177b8127[testSimple1_shard2_replica_n4] main]
   [junit4]   2> 1982360 INFO  (qtp4998343-27881) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1982360 INFO  (qtp4998343-27881) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1982361 INFO  (qtp4998343-27881) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1982361 INFO  (qtp4998343-27881) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474224288235520
   [junit4]   2> 1982364 INFO  (qtp658178728-27862) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1982365 INFO  (qtp658178728-27862) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1982365 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1982366 INFO  (qtp658178728-27862) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1982366 INFO  (qtp658178728-27862) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1982366 INFO  (searcherExecutor-8199-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple1_shard2_replica_n4] Registered new searcher 
Searcher@177b8127[testSimple1_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1982367 INFO  (searcherExecutor-8198-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple1_shard1_replica_n1] Registered new searcher 
Searcher@6a851641[testSimple1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1982367 INFO  (qtp4998343-27861) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474224294526976
   [junit4]   2> 1982367 INFO  (qtp658178728-27862) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1a1b606f[testSimple1_shard1_replica_n2] main]
   [junit4]   2> 1982369 INFO  (qtp658178728-27862) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1982371 INFO  (qtp658178728-27862) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1982371 INFO  (qtp658178728-27862) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1982372 INFO  (qtp658178728-27862) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474224299769856
   [junit4]   2> 1982372 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1982373 INFO  (searcherExecutor-8200-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple1_shard1_replica_n2] Registered new searcher 
Searcher@1a1b606f[testSimple1_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1982404 INFO  (qtp658178728-27865) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1982404 INFO  (qtp658178728-27865) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1982405 INFO  (qtp658178728-27865) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1982405 INFO  (qtp658178728-27865) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1982406 INFO  (qtp658178728-27865) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@72f2d67a[testSimple1_shard2_replica_n6] main]
   [junit4]   2> 1982407 INFO  (qtp658178728-27865) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1982407 INFO  (qtp658178728-27865) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1982408 INFO  (qtp658178728-27865) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1982408 INFO  (searcherExecutor-8201-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple1_shard2_replica_n6] Registered new searcher 
Searcher@72f2d67a[testSimple1_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1982408 INFO  (qtp658178728-27865) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474224337518592
   [junit4]   2> 1982473 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1982473 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1982473 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1982564 DEBUG (ScheduledTrigger-8189-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1982866 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1982866 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1982866 INFO  (qtp4998343-27881) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:35413/solr/testSimple1_shard2_replica_n4/
   [junit4]   2> 1982867 INFO  (qtp4998343-27881) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple1_shard2_replica_n4 url=https://127.0.0.1:35413/solr 
START replicas=[https://127.0.0.1:33497/solr/testSimple1_shard2_replica_n6/] 
nUpdates=100
   [junit4]   2> 1982870 INFO  (qtp658178728-27864) [    ] o.a.s.c.S.Request 
[testSimple1_shard2_replica_n6]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1982873 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1982873 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1982873 INFO  (qtp4998343-27861) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:35413/solr/testSimple1_shard1_replica_n1/
   [junit4]   2> 1982874 INFO  (qtp4998343-27861) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple1_shard1_replica_n1 url=https://127.0.0.1:35413/solr 
START replicas=[https://127.0.0.1:33497/solr/testSimple1_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 1982874 INFO  (qtp658178728-27871) [    ] o.a.s.c.S.Request 
[testSimple1_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1983167 INFO  (qtp4998343-27881) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple1_shard2_replica_n4 url=https://127.0.0.1:35413/solr 
DONE.  We have no versions.  sync failed.
   [junit4]   2> 1983167 INFO  (qtp4998343-27881) [    ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1983167 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1983167 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1983169 INFO  (qtp4998343-27881) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:35413/solr/testSimple1_shard2_replica_n4/ shard2
   [junit4]   2> 1983174 INFO  (qtp4998343-27861) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple1_shard1_replica_n1 url=https://127.0.0.1:35413/solr 
DONE.  We have no versions.  sync failed.
   [junit4]   2> 1983174 INFO  (qtp4998343-27861) [    ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1983174 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1983174 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1983177 INFO  (qtp4998343-27861) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:35413/solr/testSimple1_shard1_replica_n1/ shard1
   [junit4]   2> 1983288 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983288 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983288 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983320 INFO  (qtp4998343-27881) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1983331 INFO  (qtp4998343-27881) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2168
   [junit4]   2> 1983331 INFO  (qtp4998343-27861) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1983337 INFO  (qtp4998343-27861) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2172
   [junit4]   2> 1983386 INFO  (qtp658178728-27862) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2191
   [junit4]   2> 1983413 INFO  (qtp658178728-27865) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2211
   [junit4]   2> 1983415 INFO  (qtp4998343-27886) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1983513 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983513 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983513 INFO  (zkCallback-6008-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple1/state.json] for collection [testSimple1] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1983564 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1984416 INFO  (qtp4998343-27886) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=true&name=testSimple1&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:35413_solr,127.0.0.1:33497_solr&wt=javabin&version=2}
 status=0 QTime=3611
   [junit4]   2> 1984416 INFO  (qtp4998343-27884) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=false&name=testSimple2&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:33497_solr,127.0.0.1:43303_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1984418 INFO  (OverseerThreadFactory-8191-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd Create collection testSimple2
   [junit4]   2> 1984418 INFO  
(OverseerCollectionConfigSetProcessor-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1984564 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1984621 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple2",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSimple2_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33497/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1984622 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple2",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSimple2_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:43303/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1984623 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple2",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSimple2_shard2_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33497/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1984623 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple2",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSimple2_shard2_replica_n6",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:43303/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1984828 INFO  (qtp658178728-27868) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1984829 INFO  (qtp658178728-27870) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple2_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple2&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1984863 INFO  (qtp729032646-27872) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1984863 INFO  (qtp729032646-27872) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1984865 INFO  (qtp729032646-27879) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple2_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple2&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1984968 INFO  (zkCallback-6007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1984968 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1984968 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1984975 INFO  (zkCallback-6007-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1985565 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1985839 INFO  (qtp658178728-27868) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1985843 INFO  (qtp658178728-27868) [    ] o.a.s.s.IndexSchema 
[testSimple2_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1985844 INFO  (qtp658178728-27868) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1985844 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard1_replica_n1' using 
configuration from collection testSimple2, trusted=true
   [junit4]   2> 1985845 INFO  (qtp658178728-27868) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33497.solr.core.testSimple2.shard1.replica_n1' (registry 
'solr.core.testSimple2.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1985845 INFO  (qtp658178728-27868) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1985845 INFO  (qtp658178728-27868) [    ] o.a.s.c.SolrCore 
[[testSimple2_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/testSimple2_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/./testSimple2_shard1_replica_n1/data/]
   [junit4]   2> 1985863 INFO  (qtp658178728-27870) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1985867 INFO  (qtp658178728-27870) [    ] o.a.s.s.IndexSchema 
[testSimple2_shard2_replica_n4] Schema name=minimal
   [junit4]   2> 1985868 INFO  (qtp658178728-27870) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1985868 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard2_replica_n4' using 
configuration from collection testSimple2, trusted=true
   [junit4]   2> 1985869 INFO  (qtp658178728-27870) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33497.solr.core.testSimple2.shard2.replica_n4' (registry 
'solr.core.testSimple2.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1985869 INFO  (qtp658178728-27870) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1985869 INFO  (qtp658178728-27870) [    ] o.a.s.c.SolrCore 
[[testSimple2_shard2_replica_n4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/testSimple2_shard2_replica_n4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node3/./testSimple2_shard2_replica_n4/data/]
   [junit4]   2> 1985872 INFO  (qtp729032646-27872) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1985876 INFO  (qtp729032646-27872) [    ] o.a.s.s.IndexSchema 
[testSimple2_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 1985877 INFO  (qtp729032646-27872) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1985877 INFO  (qtp729032646-27872) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard1_replica_n2' using 
configuration from collection testSimple2, trusted=true
   [junit4]   2> 1985877 INFO  (qtp729032646-27872) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43303.solr.core.testSimple2.shard1.replica_n2' (registry 
'solr.core.testSimple2.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1985877 INFO  (qtp729032646-27872) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1985877 INFO  (qtp729032646-27872) [    ] o.a.s.c.SolrCore 
[[testSimple2_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node2/testSimple2_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node2/./testSimple2_shard1_replica_n2/data/]
   [junit4]   2> 1985895 INFO  (qtp729032646-27879) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1985905 INFO  (qtp729032646-27879) [    ] o.a.s.s.IndexSchema 
[testSimple2_shard2_replica_n6] Schema name=minimal
   [junit4]   2> 1985943 INFO  (qtp729032646-27879) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1985943 INFO  (qtp729032646-27879) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard2_replica_n6' using 
configuration from collection testSimple2, trusted=true
   [junit4]   2> 1985944 INFO  (qtp729032646-27879) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43303.solr.core.testSimple2.shard2.replica_n6' (registry 
'solr.core.testSimple2.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1985944 INFO  (qtp729032646-27879) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1985944 INFO  (qtp729032646-27879) [    ] o.a.s.c.SolrCore 
[[testSimple2_shard2_replica_n6] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node2/testSimple2_shard2_replica_n6],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node2/./testSimple2_shard2_replica_n6/data/]
   [junit4]   2> 1985945 INFO  (qtp658178728-27868) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1985945 INFO  (qtp658178728-27868) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1985946 INFO  (qtp658178728-27868) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1985946 INFO  (qtp658178728-27868) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1985947 INFO  (qtp658178728-27868) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2ec0e4a9[testSimple2_shard1_replica_n1] main]
   [junit4]   2> 1985948 INFO  (qtp658178728-27868) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1985948 INFO  (qtp658178728-27868) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1985949 INFO  (qtp658178728-27868) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1985949 INFO  (qtp658178728-27868) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474228050526208
   [junit4]   2> 1985950 INFO  (searcherExecutor-8218-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple2_shard1_replica_n1] Registered new searcher 
Searcher@2ec0e4a9[testSimple2_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1985954 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1985967 INFO  (qtp658178728-27870) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1985968 INFO  (qtp658178728-27870) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1985974 INFO  (qtp658178728-27870) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1985974 INFO  (qtp658178728-27870) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1985975 INFO  (qtp658178728-27870) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7cc0fc29[testSimple2_shard2_replica_n4] main]
   [junit4]   2> 1985975 INFO  (qtp729032646-27872) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1985975 INFO  (qtp729032646-27872) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1985976 INFO  (qtp658178728-27870) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1985977 INFO  (qtp658178728-27870) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1985977 INFO  (qtp729032646-27872) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1985977 INFO  (qtp729032646-27872) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1985977 INFO  (qtp658178728-27870) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1985977 INFO  (qtp658178728-27870) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474228079886336
   [junit4]   2> 1985978 INFO  (qtp729032646-27872) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@260081a[testSimple2_shard1_replica_n2] main]
   [junit4]   2> 1985979 INFO  (qtp729032646-27872) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1985979 INFO  (qtp729032646-27872) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1985980 INFO  (qtp729032646-27872) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1985980 INFO  (qtp729032646-27872) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474228083032064
   [junit4]   2> 1985981 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1985982 INFO  (searcherExecutor-8220-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple2_shard1_replica_n2] Registered new searcher 
Searcher@260081a[testSimple2_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1985988 INFO  (searcherExecutor-8219-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple2_shard2_replica_n4] Registered new searcher 
Searcher@7cc0fc29[testSimple2_shard2_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1985991 INFO  (qtp729032646-27879) [    ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1985991 INFO  (qtp729032646-27879) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1985992 INFO  (qtp729032646-27879) [    ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1985992 INFO  (qtp729032646-27879) [    ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1985993 INFO  (qtp729032646-27879) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7377d1ec[testSimple2_shard2_replica_n6] main]
   [junit4]   2> 1985993 INFO  (qtp729032646-27879) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1985993 INFO  (qtp729032646-27879) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1985994 INFO  (qtp729032646-27879) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1985994 INFO  (searcherExecutor-8222-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple2_shard2_replica_n6] Registered new searcher 
Searcher@7377d1ec[testSimple2_shard2_replica_n6] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1985994 INFO  (qtp729032646-27879) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474228097712128
   [junit4]   2> 1986081 INFO  (zkCallback-6007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986082 INFO  (zkCallback-6007-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986083 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986083 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986454 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1986454 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1986454 INFO  (qtp658178728-27868) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:33497/solr/testSimple2_shard1_replica_n1/
   [junit4]   2> 1986455 INFO  (qtp658178728-27868) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple2_shard1_replica_n1 url=https://127.0.0.1:33497/solr 
START replicas=[https://127.0.0.1:43303/solr/testSimple2_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 1986457 INFO  (qtp729032646-27981) [    ] o.a.s.c.S.Request 
[testSimple2_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1986481 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1986481 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1986481 INFO  (qtp658178728-27870) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:33497/solr/testSimple2_shard2_replica_n4/
   [junit4]   2> 1986481 INFO  (qtp658178728-27870) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple2_shard2_replica_n4 url=https://127.0.0.1:33497/solr 
START replicas=[https://127.0.0.1:43303/solr/testSimple2_shard2_replica_n6/] 
nUpdates=100
   [junit4]   2> 1986482 INFO  (qtp729032646-27873) [    ] o.a.s.c.S.Request 
[testSimple2_shard2_replica_n6]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1986565 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1986755 INFO  (qtp658178728-27868) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple2_shard1_replica_n1 url=https://127.0.0.1:33497/solr 
DONE.  We have no versions.  sync failed.
   [junit4]   2> 1986755 INFO  (qtp658178728-27868) [    ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1986755 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1986755 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1986763 INFO  (qtp658178728-27868) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:33497/solr/testSimple2_shard1_replica_n1/ shard1
   [junit4]   2> 1986782 INFO  (qtp658178728-27870) [    ] o.a.s.u.PeerSync 
PeerSync: core=testSimple2_shard2_replica_n4 url=https://127.0.0.1:33497/solr 
DONE.  We have no versions.  sync failed.
   [junit4]   2> 1986782 INFO  (qtp658178728-27870) [    ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1986782 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1986782 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1986784 INFO  (qtp658178728-27870) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:33497/solr/testSimple2_shard2_replica_n4/ shard2
   [junit4]   2> 1986886 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986887 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986891 INFO  (zkCallback-6007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986891 INFO  (zkCallback-6007-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1986914 INFO  (qtp658178728-27868) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1986921 INFO  (qtp658178728-27868) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2093
   [junit4]   2> 1986935 INFO  (qtp658178728-27870) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1986936 INFO  (qtp658178728-27870) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple2_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple2&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2107
   [junit4]   2> 1986997 INFO  (qtp729032646-27872) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2133
   [junit4]   2> 1986998 INFO  (qtp729032646-27879) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple2_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple2&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2132
   [junit4]   2> 1987003 INFO  (qtp4998343-27884) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1987100 INFO  (zkCallback-6007-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1987100 INFO  (zkCallback-6007-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1987102 INFO  (zkCallback-6009-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1987103 INFO  (zkCallback-6009-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple2/state.json] for collection [testSimple2] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1987565 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1988004 INFO  (qtp4998343-27884) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=false&name=testSimple2&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:33497_solr,127.0.0.1:43303_solr&wt=javabin&version=2}
 status=0 QTime=3587
   [junit4]   2> 1988005 INFO  (qtp4998343-27949) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf&maxShardsPerNode=3&autoAddReplicas=false&name=testSimple3&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=127.0.0.1:35413_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1988006 INFO  
(OverseerCollectionConfigSetProcessor-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1988009 INFO  (OverseerThreadFactory-8191-thread-3) [    ] 
o.a.s.c.CreateCollectionCmd Create collection testSimple3
   [junit4]   2> 1988226 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple3",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSimple3_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35413/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1988226 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple3",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"testSimple3_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35413/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1988228 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSimple3",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "core":"testSimple3_shard3_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35413/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1988430 INFO  (qtp4998343-27948) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple3_shard1_replica_n1&action=CREATE&numShards=3&collection=testSimple3&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1988430 INFO  (qtp4998343-27869) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple3_shard2_replica_n2&action=CREATE&numShards=3&collection=testSimple3&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1988431 INFO  (qtp4998343-27861) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=testSimple3_shard3_replica_n4&action=CREATE&numShards=3&collection=testSimple3&shard=shard3&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1988533 INFO  (zkCallback-6008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple3/state.json] for collection [testSimple3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1988533 INFO  (zkCallback-6008-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testSimple3/state.json] for collection [testSimple3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 1988565 DEBUG (ScheduledTrigger-8189-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: [127.0.0.1:35413_solr, 127.0.0.1:43303_solr, 
127.0.0.1:33497_solr]
   [junit4]   2> 1989438 INFO  (qtp4998343-27948) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1989440 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1989440 INFO  (qtp4998343-27869) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1989446 INFO  (qtp4998343-27948) [    ] o.a.s.s.IndexSchema 
[testSimple3_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1989448 INFO  (qtp4998343-27948) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1989448 INFO  (qtp4998343-27948) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'testSimple3_shard1_replica_n1' using configuration from 
collection testSimple3, trusted=true
   [junit4]   2> 1989448 INFO  (qtp4998343-27948) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35413.solr.core.testSimple3.shard1.replica_n1' (registry 
'solr.core.testSimple3.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1989448 INFO  (qtp4998343-27948) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1989448 INFO  (qtp4998343-27948) [    ] o.a.s.c.SolrCore 
[[testSimple3_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/testSimple3_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/./testSimple3_shard1_replica_n1/data/]
   [junit4]   2> 1989451 INFO  (qtp4998343-27861) [    ] o.a.s.s.IndexSchema 
[testSimple3_shard3_replica_n4] Schema name=minimal
   [junit4]   2> 1989452 INFO  (qtp4998343-27869) [    ] o.a.s.s.IndexSchema 
[testSimple3_shard2_replica_n2] Schema name=minimal
   [junit4]   2> 1989454 INFO  (qtp4998343-27869) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1989454 INFO  (qtp4998343-27869) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'testSimple3_shard2_replica_n2' using configuration from 
collection testSimple3, trusted=true
   [junit4]   2> 1989454 INFO  (qtp4998343-27869) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35413.solr.core.testSimple3.shard2.replica_n2' (registry 
'solr.core.testSimple3.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1989455 INFO  (qtp4998343-27869) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1989455 INFO  (qtp4998343-27869) [    ] o.a.s.c.SolrCore 
[[testSimple3_shard2_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/testSimple3_shard2_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/./testSimple3_shard2_replica_n2/data/]
   [junit4]   2> 1989457 INFO  (qtp4998343-27861) [    ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1989457 INFO  (qtp4998343-27861) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'testSimple3_shard3_replica_n4' using configuration from 
collection testSimple3, trusted=true
   [junit4]   2> 1989457 INFO  (qtp4998343-27861) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35413.solr.core.testSimple3.shard3.replica_n4' (registry 
'solr.core.testSimple3.shard3.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@72bcf39a
   [junit4]   2> 1989458 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1989458 INFO  (qtp4998343-27861) [    ] o.a.s.c.SolrCore 
[[testSimple3_shard3_replica_n4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/testSimple3_shard3_replica_n4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001/tempDir-001/node1/./testSimple3_shard3_replica_n4/data/]
   [junit4]   2> 1989505 INFO  (qtp4998343-27948) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1989505 INFO  (qtp4998343-27948) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1989506 INFO  (qtp4998343-27948) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1989507 INFO  (qtp4998343-27948) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1989508 INFO  (qtp4998343-27948) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@146c7ac9[testSimple3_shard1_replica_n1] main]
   [junit4]   2> 1989509 INFO  (qtp4998343-27948) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1989509 INFO  (qtp4998343-27948) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1989510 INFO  (qtp4998343-27948) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1989510 INFO  (qtp4998343-27948) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1583474231784505344
   [junit4]   2> 1989512 INFO  (searcherExecutor-8238-thread-1) [    ] 
o.a.s.c.SolrCore [testSimple3_shard1_replica_n1] Registered new searcher 
Searcher@146c7ac9[testSimple3_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:35413/solr/testSimple3_shard1_replica_n1/
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] o.a.s.c.SyncStrategy 
https://127.0.0.1:35413/solr/testSimple3_shard1_replica_n1/ has no replicas
   [junit4]   2> 1989522 INFO  (qtp4998343-27948) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1989524 INFO  (qtp4998343-27948) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:35413/solr/testSimple3_shard1_replica_n1/ shard1
   [junit4]   2> 1989524 INFO  (qtp4998343-27869) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1989524 INFO  (qtp4998343-27869) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1989525 INFO  (qtp4998343-27869) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1989525 INFO  (qtp4998343-27869) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1989526 INFO  (qtp4998343-27869) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@69766753[testSimple3_shard2_replica_n2] main]
   [junit4]   2> 1989527 INFO  (qtp4998343-27869) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1989527 INFO  (qtp4998343-27869) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperSt

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

 solr_43303, domain = solr.core.testSimple2.shard2.replica_n6, service url = 
null, agent id = null] for registry solr.core.testSimple2.shard2.replica_n6 / 
com.codahale.metrics.MetricRegistry@71b2880c
   [junit4]   2> 2124194 INFO  (coreCloseExecutor-8311-thread-5) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testSimple3.shard3.leader, tag=1847057393
   [junit4]   2> 2124194 INFO  (coreCloseExecutor-8311-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.testSimple3.shard2.replica_n2, tag=60728318
   [junit4]   2> 2124194 INFO  (coreCloseExecutor-8311-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5029ffa2: rootName = 
solr_35413, domain = solr.core.testSimple3.shard2.replica_n2, service url = 
null, agent id = null] for registry solr.core.testSimple3.shard2.replica_n2 / 
com.codahale.metrics.MetricRegistry@70265caf
   [junit4]   2> 2124194 INFO  (coreCloseExecutor-8312-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testSimple2.shard2.leader, tag=1731993660
   [junit4]   2> 2124195 INFO  (jetty-closer-5993-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@39935b15{/solr,null,UNAVAILABLE}
   [junit4]   2> 2124199 INFO  (coreCloseExecutor-8311-thread-4) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.testSimple3.shard2.leader, tag=60728318
   [junit4]   2> 2124199 INFO  (jetty-closer-5993-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98967138882224136-127.0.0.1:35413_solr-n_0000000000) closing
   [junit4]   2> 2124199 INFO  
(OverseerStateUpdate-98967138882224136-127.0.0.1:35413_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:35413_solr
   [junit4]   2> 2124199 WARN  
(OverseerAutoScalingTriggerThread-98967138882224136-127.0.0.1:35413_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 2124200 DEBUG (jetty-closer-5993-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 2124200 INFO  (jetty-closer-5993-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@43a08c72{/solr,null,UNAVAILABLE}
   [junit4]   2> 2124200 ERROR 
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-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> 2124200 INFO  
(SUITE-AutoAddReplicasIntegrationTest-seed#[52E893DDAB0ACAEA]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:38613 38613
   [junit4]   2> 2128527 INFO  (Thread-4329) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:38613 38613
   [junit4]   2> 2128527 WARN  (Thread-4329) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/aliases.json
   [junit4]   2>        5       /solr/security.json
   [junit4]   2>        5       /solr/configs/conf
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        32      /solr/collections/testSimple2/state.json
   [junit4]   2>        21      /solr/collections/testSimple1/state.json
   [junit4]   2>        6       /solr/clusterprops.json
   [junit4]   2>        6       /solr/clusterstate.json
   [junit4]   2>        5       /solr/collections/testSimple3/state.json
   [junit4]   2>        4       
/solr/overseer_elect/election/98967138882224136-127.0.0.1:35413_solr-n_0000000000
   [junit4]   2>        3       
/solr/collections/testSimple1/leader_elect/shard1/election/98967138882224136-core_node3-n_0000000000
   [junit4]   2>        3       
/solr/collections/testSimple1/leader_elect/shard2/election/98967138882224136-core_node7-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/live_nodes
   [junit4]   2>        6       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.AutoAddReplicasIntegrationTest_52E893DDAB0ACAEA-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@70baad7a),
 locale=uz-Latn-UZ, timezone=Asia/Qyzylorda
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 10-ea 
(64-bit)/cpus=8,threads=1,free=305063880,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestFieldResource, 
HdfsChaosMonkeySafeLeaderTest, SolrXmlInZkTest, TestDocumentBuilder, 
LeaderFailoverAfterPartitionTest, PrimUtilsTest, AddBlockUpdateTest, 
TlogReplayBufferedWhileIndexingTest, DirectUpdateHandlerTest, 
TestManagedSchemaThreadSafety, SuggesterTSTTest, TestFastLRUCache, 
TestNoOpRegenerator, TestSolrConfigHandler, TestCursorMarkWithoutUniqueKey, 
TestRTimerTree, TolerantUpdateProcessorTest, MissingSegmentRecoveryTest, 
TestEmbeddedSolrServerAdminHandler, RequestHandlersTest, SolrShardReporterTest, 
TestSurroundQueryParser, OutputWriterTest, SampleTest, PingRequestHandlerTest, 
TestRestManager, SegmentsInfoRequestHandlerTest, TestScoreJoinQPNoScore, 
TestStressReorder, FullHLLTest, CloudMLTQParserTest, 
TestSolrConfigHandlerConcurrent, OpenCloseCoreStressTest, NumericFieldsTest, 
SolrCmdDistributorTest, ConfigureRecoveryStrategyTest, 
TestInPlaceUpdatesDistrib, TestExportWriter, SolrJmxReporterTest, 
TestAnalyzeInfixSuggestions, OverseerTaskQueueTest, SpellingQueryConverterTest, 
TestCloudManagedSchema, TestClusterProperties, MoveReplicaTest, 
TestRequestStatusCollectionAPI, AssignTest, CloudExitableDirectoryReaderTest, 
TestDFISimilarityFactory, TestCryptoKeys, SuggesterFSTTest, 
CoreAdminRequestStatusTest, DistributedQueryComponentOptimizationTest, 
DeleteLastCustomShardedReplicaTest, TestPullReplicaErrorHandling, 
SolrGangliaReporterTest, TestDocSet, TestSmileRequest, TestCloudInspectUtil, 
ExitableDirectoryReaderTest, TestBackupRepositoryFactory, 
TestDistributedStatsComponentCardinality, HdfsUnloadDistributedZkTest, 
TestSolrCloudWithHadoopAuthPlugin, BadCopyFieldTest, CdcrBidirectionalTest, 
ShowFileRequestHandlerTest, TestJsonFacetRefinement, 
ClassificationUpdateProcessorTest, TestLegacyField, TestJettySolrRunner, 
TestOnReconnectListenerSupport, TestAnalyzedSuggestions, 
TestSimpleTrackingShardHandler, TestSolr4Spatial, ZkFailoverTest, 
HdfsRecoverLeaseTest, HdfsSyncSliceTest, AddReplicaTest, SparseHLLTest, 
DocValuesMultiTest, TestCollationField, JvmMetricsTest, TestCustomStream, 
TestOrdValues, TestLuceneMatchVersion, ShardRoutingTest, 
BasicAuthIntegrationTest, SolrIndexConfigTest, TestConfigSetsAPI, 
TestManagedStopFilterFactory, DistributedFacetPivotSmallTest, 
DistributedDebugComponentTest, AutoScalingHandlerTest, 
PathHierarchyTokenizerFactoryTest, HdfsBasicDistributedZk2Test, 
TestBM25SimilarityFactory, TestSchemaVersionResource, SortSpecParsingTest, 
TestFieldCacheVsDocValues, RegexBoostProcessorTest, SynonymTokenizerTest, 
ShardRoutingCustomTest, TestStressLucene, UninvertDocValuesMergePolicyTest, 
TestConfigSetProperties, TestSchemaNameResource, TestTlogReplica, 
TestSha256AuthenticationProvider, TestPseudoReturnFields, 
TestAuthorizationFramework, TestAtomicUpdateErrorCases, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestFieldCacheReopen, 
TestMaxScoreQueryParser, BlobRepositoryCloudTest, 
SimpleCollectionCreateDeleteTest, SaslZkACLProviderTest, 
TestDynamicFieldCollectionResource, LeaderInitiatedRecoveryOnShardRestartTest, 
ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, BasicZkTest, 
RecoveryZkTest, ClusterStateUpdateTest, LeaderElectionTest, TestZkChroot, 
TestDistributedGrouping, TestFaceting, TestRecovery, 
TermVectorComponentDistributedTest, ZkControllerTest, TestStressVersions, 
DistributedTermsComponentTest, TestRangeQuery, 
DistributedQueryElevationComponentTest, SolrIndexSplitterTest, 
TestCoreDiscovery, AnalysisAfterCoreReloadTest, 
SignatureUpdateProcessorFactoryTest, CoreAdminHandlerTest, 
SolrRequestParserTest, SuggesterTest, TestTrie, SpatialFilterTest, 
SuggesterWFSTTest, PolyFieldTest, SchemaVersionSpecificBehaviorTest, 
SolrCoreCheckLockOnStartupTest, TestUpdate, QueryEqualityTest, 
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, 
SortByFunctionTest, TestRemoteStreaming, TestSolrDeletionPolicy1, 
XsltUpdateRequestHandlerTest, DebugComponentTest, LukeRequestHandlerTest, 
TestQueryUtils, TestWriterPerf, DocumentAnalysisRequestHandlerTest, 
TestQueryTypes, TestOmitPositions, XmlUpdateRequestHandlerTest, 
DocumentBuilderTest, TestValueSourceCache, MoreLikeThisHandlerTest, 
TestSolrQueryParser, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, 
IndexSchemaTest, TestJmxIntegration, ReturnFieldsTest, MBeansHandlerTest, 
URLClassifyProcessorTest, PreAnalyzedFieldTest, TestSuggestSpellingConverter, 
DateFieldTest, TestUtils, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, 
DistributedIntervalFacetingTest, AliasIntegrationTest, 
AsyncCallRequestStatusResponseTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, 
ConcurrentDeleteAndCreateCollectionTest, ConfigSetsAPITest, 
ConnectionManagerTest, CreateCollectionCleanupTest, DeleteNodeTest, 
DeleteReplicaTest, DistributedVersionInfoTest, 
LeaderFailureAfterFreshStartTest, MoveReplicaHDFSFailoverTest, 
TestCloudJSONFacetJoinDomain, TestCollectionAPI, 
TestDeleteCollectionOnDownNodes, TestDownShardTolerantSearch, 
TestLeaderElectionWithEmptyReplica, TestLockTree, TestMiniSolrCloudClusterSSL, 
TestRandomFlRTGCloud, TestRandomRequestDistribution, 
TestShortCircuitedRequests, TestSizeLimitedDistributedMap, 
TestSkipOverseerOperations, TestStressLiveNodes, 
VMParamsZkACLAndCredentialsProvidersTest, AutoAddReplicasIntegrationTest]
   [junit4] Completed [584/749 (1!)] on J1 in 148.26s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to