Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Windows/121/
Java: 64bit/jdk1.8.0_144 -XX:-UseCompressedOops -XX:+UseSerialGC

2 tests failed.
FAILED:  org.apache.solr.cloud.TestPullReplica.testKillLeader

Error Message:
Replica state not updated in cluster state null Live Nodes: 
[127.0.0.1:60554_solr, 127.0.0.1:60557_solr] Last available state: 
DocCollection(pull_replica_test_kill_leader//collections/pull_replica_test_kill_leader/state.json/6)={
   "pullReplicas":"1",   "replicationFactor":"1",   "shards":{"shard1":{       
"range":"80000000-7fffffff",       "state":"active",       "replicas":{         
"core_node1":{           
"core":"pull_replica_test_kill_leader_shard1_replica_n1",           
"base_url":"http://127.0.0.1:60557/solr";,           
"node_name":"127.0.0.1:60557_solr",           "state":"down",           
"type":"NRT",           "leader":"true"},         "core_node2":{           
"core":"pull_replica_test_kill_leader_shard1_replica_p1",           
"base_url":"http://127.0.0.1:60554/solr";,           
"node_name":"127.0.0.1:60554_solr",           "state":"active",           
"type":"PULL"}}}},   "router":{"name":"compositeId"},   
"maxShardsPerNode":"100",   "autoAddReplicas":"false",   "nrtReplicas":"1",   
"tlogReplicas":"0"}

Stack Trace:
java.lang.AssertionError: Replica state not updated in cluster state
null
Live Nodes: [127.0.0.1:60554_solr, 127.0.0.1:60557_solr]
Last available state: 
DocCollection(pull_replica_test_kill_leader//collections/pull_replica_test_kill_leader/state.json/6)={
  "pullReplicas":"1",
  "replicationFactor":"1",
  "shards":{"shard1":{
      "range":"80000000-7fffffff",
      "state":"active",
      "replicas":{
        "core_node1":{
          "core":"pull_replica_test_kill_leader_shard1_replica_n1",
          "base_url":"http://127.0.0.1:60557/solr";,
          "node_name":"127.0.0.1:60557_solr",
          "state":"down",
          "type":"NRT",
          "leader":"true"},
        "core_node2":{
          "core":"pull_replica_test_kill_leader_shard1_replica_p1",
          "base_url":"http://127.0.0.1:60554/solr";,
          "node_name":"127.0.0.1:60554_solr",
          "state":"active",
          "type":"PULL"}}}},
  "router":{"name":"compositeId"},
  "maxShardsPerNode":"100",
  "autoAddReplicas":"false",
  "nrtReplicas":"1",
  "tlogReplicas":"0"}
        at 
__randomizedtesting.SeedInfo.seed([3EA8302BDC0DCB1D:77BEC49FBEB65F4B]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
        at 
org.apache.solr.cloud.TestPullReplica.doTestNoLeader(TestPullReplica.java:401)
        at 
org.apache.solr.cloud.TestPullReplica.testKillLeader(TestPullReplica.java:290)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.cloud.CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster

Error Message:
Document mismatch on target after sync expected:<2000> but was:<1100>

Stack Trace:
java.lang.AssertionError: Document mismatch on target after sync 
expected:<2000> but was:<1100>
        at 
__randomizedtesting.SeedInfo.seed([3EA8302BDC0DCB1D:EAED7B723B5B78E6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.cloud.CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster(CdcrBootstrapTest.java:309)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 10895 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestPullReplica
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\init-core-data-001
   [junit4]   2> 100051 WARN  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
   [junit4]   2> 100051 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 100051 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 100051 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001
   [junit4]   2> 100051 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 100051 INFO  (Thread-242) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 100051 INFO  (Thread-242) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 100073 ERROR (Thread-242) [    ] 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> 100163 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:60550
   [junit4]   2> 100182 INFO  (jetty-launcher-108-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 100183 INFO  (jetty-launcher-108-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5616280a{/solr,null,AVAILABLE}
   [junit4]   2> 100186 INFO  (jetty-launcher-108-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@180740d2{HTTP/1.1,[http/1.1]}{127.0.0.1:60554}
   [junit4]   2> 100186 INFO  (jetty-launcher-108-thread-2) [    ] 
o.e.j.s.Server Started @104053ms
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60554}
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 100187 ERROR (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 100187 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-30T11:56:07.667Z
   [junit4]   2> 100188 INFO  (jetty-launcher-108-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@31f3325b{/solr,null,AVAILABLE}
   [junit4]   2> 100188 INFO  (jetty-launcher-108-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3d36dbf9{HTTP/1.1,[http/1.1]}{127.0.0.1:60557}
   [junit4]   2> 100189 INFO  (jetty-launcher-108-thread-1) [    ] 
o.e.j.s.Server Started @104055ms
   [junit4]   2> 100189 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60557}
   [junit4]   2> 100194 ERROR (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 100194 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 100194 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 100194 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 100194 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-30T11:56:07.674Z
   [junit4]   2> 100208 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 100208 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 100434 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 0x15e32ffa2010001, 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.lang.Thread.run(Thread.java:748)
   [junit4]   2> 100440 INFO  (jetty-launcher-108-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60550/solr
   [junit4]   2> 100440 INFO  (jetty-launcher-108-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60550/solr
   [junit4]   2> 100448 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 0x15e32ffa2010004, 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.lang.Thread.run(Thread.java:748)
   [junit4]   2> 100449 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 0x15e32ffa2010003, 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.lang.Thread.run(Thread.java:748)
   [junit4]   2> 100619 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 100620 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:60557_solr
   [junit4]   2> 100623 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.Overseer Overseer 
(id=98572315364753414-127.0.0.1:60557_solr-n_0000000000) starting
   [junit4]   2> 100634 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60557_solr
   [junit4]   2> 100636 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 100653 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 100661 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 100661 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60554_solr
   [junit4]   2> 100661 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 100661 INFO  
(zkCallback-120-thread-1-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 101035 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60554.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101067 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60557.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101124 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60554.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101125 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60554.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101130 INFO  (jetty-launcher-108-thread-2) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node2\.
   [junit4]   2> 101239 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60557.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101239 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60557.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 101239 INFO  (jetty-launcher-108-thread-1) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node1\.
   [junit4]   2> 101410 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 0x15e32ffa2010007, 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.lang.Thread.run(Thread.java:748)
   [junit4]   2> 101410 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 101410 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:60550/solr ready
   [junit4]   2> 101430 INFO  
(SUITE-TestPullReplica-seed#[3EA8302BDC0DCB1D]-worker) [    ] 
o.a.s.c.TestPullReplica Using legacyCloud?: false
   [junit4]   2> 101441 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params 
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 101449 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=4
   [junit4]   2> 101538 INFO  
(TEST-TestPullReplica.testAddDocs-seed#[3EA8302BDC0DCB1D]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAddDocs
   [junit4]   2> 101538 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=2&replicationFactor=1&collection.configName=conf&maxShardsPerNode=100&name=pull_replica_test_add_docs&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 101546 INFO  
(OverseerThreadFactory-422-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
pull_replica_test_add_docs
   [junit4]   2> 101547 WARN  
(OverseerThreadFactory-422-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.CreateCollectionCmd Specified number of 
replicas of 3 on collection pull_replica_test_add_docs is higher than the 
number of Solr instances currently live or live and part of your 
createNodeSet(2). It's unusual to run two replica of the same slice on the same 
Solr-instance.
   [junit4]   2> 101665 INFO  
(OverseerStateUpdate-98572315364753414-127.0.0.1:60557_solr-n_0000000000) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"pull_replica_test_add_docs",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"pull_replica_test_add_docs_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:60557/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 101667 INFO  
(OverseerStateUpdate-98572315364753414-127.0.0.1:60557_solr-n_0000000000) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"pull_replica_test_add_docs",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"pull_replica_test_add_docs_shard1_replica_p1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:60554/solr";,
   [junit4]   2>   "type":"PULL"} 
   [junit4]   2> 101668 INFO  
(OverseerStateUpdate-98572315364753414-127.0.0.1:60557_solr-n_0000000000) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"pull_replica_test_add_docs",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"pull_replica_test_add_docs_shard1_replica_p2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:60557/solr";,
   [junit4]   2>   "type":"PULL"} 
   [junit4]   2> 101880 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_n1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 101880 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 101880 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 101880 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p2&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL
   [junit4]   2> 101880 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 102007 INFO  
(zkCallback-120-thread-1-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 102007 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 102008 INFO  
(zkCallback-120-thread-2-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 102008 INFO  
(zkCallback-119-thread-2-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103026 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 103026 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 103036 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 103052 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.IndexSchema 
[pull_replica_test_add_docs_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 103052 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.IndexSchema 
[pull_replica_test_add_docs_shard1_replica_p2] Schema name=minimal
   [junit4]   2> 103052 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.s.IndexSchema 
[pull_replica_test_add_docs_shard1_replica_p1] Schema name=minimal
   [junit4]   2> 103079 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 103079 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.CoreContainer Creating 
SolrCore 'pull_replica_test_add_docs_shard1_replica_p1' using configuration 
from collection pull_replica_test_add_docs, trusted=true
   [junit4]   2> 103080 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_60554.solr.core.pull_replica_test_add_docs.shard1.replica_p1' (registry 
'solr.core.pull_replica_test_add_docs.shard1.replica_p1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 103080 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 103080 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrCore 
[[pull_replica_test_add_docs_shard1_replica_p1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node2\pull_replica_test_add_docs_shard1_replica_p1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node2\.\pull_replica_test_add_docs_shard1_replica_p1\data\]
   [junit4]   2> 103080 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 103080 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.CoreContainer Creating 
SolrCore 'pull_replica_test_add_docs_shard1_replica_n1' using configuration 
from collection pull_replica_test_add_docs, trusted=true
   [junit4]   2> 103082 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 103082 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.CoreContainer Creating 
SolrCore 'pull_replica_test_add_docs_shard1_replica_p2' using configuration 
from collection pull_replica_test_add_docs, trusted=true
   [junit4]   2> 103083 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_60557.solr.core.pull_replica_test_add_docs.shard1.replica_n1' (registry 
'solr.core.pull_replica_test_add_docs.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 103083 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 103083 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore 
[[pull_replica_test_add_docs_shard1_replica_n1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node1\pull_replica_test_add_docs_shard1_replica_n1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node1\.\pull_replica_test_add_docs_shard1_replica_n1\data\]
   [junit4]   2> 103088 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 
'solr_60557.solr.core.pull_replica_test_add_docs.shard1.replica_p2' (registry 
'solr.core.pull_replica_test_add_docs.shard1.replica_p2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3b81092a
   [junit4]   2> 103088 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 103088 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore 
[[pull_replica_test_add_docs_shard1_replica_p2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node1\pull_replica_test_add_docs_shard1_replica_p2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestPullReplica_3EA8302BDC0DCB1D-001\tempDir-001\node1\.\pull_replica_test_add_docs_shard1_replica_p2\data\]
   [junit4]   2> 103317 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 103317 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 103317 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 103317 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 103333 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 103333 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 103358 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@936066f[pull_replica_test_add_docs_shard1_replica_p1] main]
   [junit4]   2> 103360 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 103360 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 103363 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 103363 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 103363 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 103364 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.ZkController 
pull_replica_test_add_docs_shard1_replica_p1 starting background replication 
from leader
   [junit4]   2> 103365 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2babcc56[pull_replica_test_add_docs_shard1_replica_n1] main]
   [junit4]   2> 103367 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.ReplicateFromLeader 
Will start replication from leader with poll interval: 00:00:03
   [junit4]   2> 103367 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 103368 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 103369 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 103371 INFO  
(searcherExecutor-428-thread-1-processing-n:127.0.0.1:60557_solr 
x:pull_replica_test_add_docs_shard1_replica_n1 s:shard1 
c:pull_replica_test_add_docs r:core_node1) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_n1] Registered new searcher 
Searcher@2babcc56[pull_replica_test_add_docs_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103372 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1577157049295306752
   [junit4]   2> 103375 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@30d15ee[pull_replica_test_add_docs_shard1_replica_p2] main]
   [junit4]   2> 103379 INFO  
(searcherExecutor-427-thread-1-processing-n:127.0.0.1:60554_solr 
x:pull_replica_test_add_docs_shard1_replica_p1 s:shard1 
c:pull_replica_test_add_docs r:core_node2) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_p1] Registered new searcher 
Searcher@936066f[pull_replica_test_add_docs_shard1_replica_p1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103382 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 103383 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 103384 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 103384 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.ZkController 
pull_replica_test_add_docs_shard1_replica_p2 starting background replication 
from leader
   [junit4]   2> 103385 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.ReplicationHandler Poll 
scheduled at an interval of 3000ms
   [junit4]   2> 103385 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.ReplicateFromLeader 
Will start replication from leader with poll interval: 00:00:03
   [junit4]   2> 103390 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.ReplicationHandler Poll 
scheduled at an interval of 3000ms
   [junit4]   2> 103390 INFO  
(searcherExecutor-429-thread-1-processing-n:127.0.0.1:60557_solr 
x:pull_replica_test_add_docs_shard1_replica_p2 s:shard1 
c:pull_replica_test_add_docs r:core_node3) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_p2] Registered new searcher 
Searcher@30d15ee[pull_replica_test_add_docs_shard1_replica_p2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:60557/solr/pull_replica_test_add_docs_shard1_replica_n1/
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:60557/solr/pull_replica_test_add_docs_shard1_replica_n1/ has 
no replicas
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 103395 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:60557/solr/pull_replica_test_add_docs_shard1_replica_n1/ shard1
   [junit4]   2> 103505 INFO  
(zkCallback-120-thread-2-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103505 INFO  
(zkCallback-120-thread-1-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103505 INFO  
(zkCallback-119-thread-2-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103505 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103520 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 103520 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_n1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1641
   [junit4]   2> 103600 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Replica 
core_node1 is leader but it's state is down, skipping replication
   [junit4]   2> 103723 INFO  
(zkCallback-120-thread-1-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103723 INFO  
(zkCallback-120-thread-2-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103723 INFO  
(zkCallback-119-thread-2-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103723 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 103847 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Updated 
masterUrl to 
http://127.0.0.1:60557/solr/pull_replica_test_add_docs_shard1_replica_n1/
   [junit4]   2> 103850 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 103851 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Master's 
generation: 1
   [junit4]   2> 103851 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Master's 
version: 0
   [junit4]   2> 103851 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Slave's 
generation: 1
   [junit4]   2> 103851 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Slave's 
version: 0
   [junit4]   2> 104411 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p1&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=2536
   [junit4]   2> 104427 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=pull_replica_test_add_docs_shard1_replica_p2&action=CREATE&numShards=1&collection=pull_replica_test_add_docs&shard=shard1&wt=javabin&version=2&replicaType=PULL}
 status=0 QTime=2540
   [junit4]   2> 104427 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 104561 INFO  
(zkCallback-120-thread-2-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 104561 INFO  
(zkCallback-120-thread-1-processing-n:127.0.0.1:60554_solr) 
[n:127.0.0.1:60554_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 104562 INFO  
(zkCallback-119-thread-1-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 104562 INFO  
(zkCallback-119-thread-2-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/pull_replica_test_add_docs/state.json] for collection 
[pull_replica_test_add_docs] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 105437 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=2&replicationFactor=1&collection.configName=conf&maxShardsPerNode=100&name=pull_replica_test_add_docs&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
 status=0 QTime=3901
   [junit4]   2> 105461 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1577157051484733440)]} 0 14
   [junit4]   2> 105477 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1577157051502559232,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105477 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling 
setCommitData with IW:org.apache.solr.update.SolrIndexWriter@62ede313 
commitCommandVersion:1577157051502559232
   [junit4]   2> 105477 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@194ad82c[pull_replica_test_add_docs_shard1_replica_n1] main]
   [junit4]   2> 105489 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 105489 INFO  
(searcherExecutor-428-thread-1-processing-n:127.0.0.1:60557_solr 
x:pull_replica_test_add_docs_shard1_replica_n1 s:shard1 
c:pull_replica_test_add_docs r:core_node1) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_n1] Registered new searcher 
Searcher@194ad82c[pull_replica_test_add_docs_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 105489 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=pull_replica_test_add_docs:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 21
   [junit4]   2> 105489 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 105489 INFO  (qtp1000326677-766) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 105567 INFO  
(OverseerCollectionConfigSetProcessor-98572315364753414-127.0.0.1:60557_solr-n_0000000000)
 [n:127.0.0.1:60557_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 105590 INFO  (qtp1000326677-766) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 105707 INFO  (qtp1000326677-765) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 105808 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 105911 INFO  (qtp1000326677-763) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106020 INFO  (qtp1000326677-763) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106121 INFO  (qtp1000326677-763) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106223 INFO  (qtp1000326677-763) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106324 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Last 
replication failed, so I'll force replication
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Updated 
masterUrl to 
http://127.0.0.1:60557/solr/pull_replica_test_add_docs_shard1_replica_n1/
   [junit4]   2> 106393 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Master's 
generation: 2
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Master's 
version: 1504094172957
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Slave's 
generation: 1
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Slave's 
version: 0
   [junit4]   2> 106393 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Starting 
replication process
   [junit4]   2> 106437 INFO  (qtp1000326677-770) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106444 INFO  (qtp1353079362-777) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=47
   [junit4]   2> 106444 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Number of 
files in latest index in master: 15
   [junit4]   2> 106445 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Starting 
download (fullCopy=true) to MockDirectoryWrapper(RAMDirectory@43b415ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@66b9492)
   [junit4]   2> 106466 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=11
   [junit4]   2> 106473 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106473 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106473 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.pos&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106497 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106502 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene70_0.dvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-777) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.dii&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene70_0.dvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106503 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.dim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106508 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106508 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106509 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106510 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher Total time 
taken for download (fullCopy=true,bytesDownloaded=2348) : 0 secs (null 
bytes/sec) to MockDirectoryWrapper(RAMDirectory@43b415ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@66b9492)
   [junit4]   2> 106511 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrCore Updating index 
properties... index=index.20170830085613925
   [junit4]   2> 106512 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.h.IndexFetcher removing 
old index directory MockDirectoryWrapper(RAMDirectory@1cb39fbd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8660b08)
   [junit4]   2> 106515 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 106516 INFO  (indexFetcher-441-thread-1) 
[n:127.0.0.1:60554_solr c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@640afe72[pull_replica_test_add_docs_shard1_replica_p1] main]
   [junit4]   2> 106519 INFO  
(searcherExecutor-427-thread-1-processing-n:127.0.0.1:60554_solr 
x:pull_replica_test_add_docs_shard1_replica_p1 s:shard1 
c:pull_replica_test_add_docs r:core_node2) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_p1] Registered new searcher 
Searcher@640afe72[pull_replica_test_add_docs_shard1_replica_p1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 106546 INFO  (qtp1000326677-766) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 106561 INFO  (qtp1000326677-765) [n:127.0.0.1:60554_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node2 
x:pull_replica_test_add_docs_shard1_replica_p1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p1]  webapp=/solr 
path=/admin/plugins params={qt=/admin/plugins&stats=true&wt=javabin&version=2} 
status=0 QTime=13
   [junit4]   2> 106566 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106668 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106769 INFO  (qtp1353079362-777) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106845 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 106845 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Master's 
generation: 2
   [junit4]   2> 106845 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Master's 
version: 1504094172957
   [junit4]   2> 106845 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Slave's 
generation: 1
   [junit4]   2> 106845 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Slave's 
version: 0
   [junit4]   2> 106845 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Starting 
replication process
   [junit4]   2> 106847 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=0
   [junit4]   2> 106848 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Number of 
files in latest index in master: 15
   [junit4]   2> 106851 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Starting 
download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@4c0083e1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d1c80e2)
   [junit4]   2> 106852 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106853 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106854 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106855 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.pos&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106856 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106857 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106858 INFO  (qtp1353079362-777) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106871 INFO  (qtp1353079362-773) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106871 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 106873 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene70_0.dvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-772) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.dii&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene70_0.dvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.dim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-774) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-779) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106874 INFO  (qtp1353079362-777) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node1 
x:pull_replica_test_add_docs_shard1_replica_n1] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_n1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 106880 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.h.IndexFetcher Total time 
taken for download (fullCopy=false,bytesDownloaded=2348) : 0 secs (null 
bytes/sec) to MockDirectoryWrapper(RAMDirectory@4c0083e1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5d1c80e2)
   [junit4]   2> 106880 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 106880 INFO  (indexFetcher-443-thread-1) 
[n:127.0.0.1:60557_solr c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@226fa50f[pull_replica_test_add_docs_shard1_replica_p2] main]
   [junit4]   2> 106880 INFO  
(searcherExecutor-429-thread-1-processing-n:127.0.0.1:60557_solr 
x:pull_replica_test_add_docs_shard1_replica_p2 s:shard1 
c:pull_replica_test_add_docs r:core_node3) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.SolrCore 
[pull_replica_test_add_docs_shard1_replica_p2] Registered new searcher 
Searcher@226fa50f[pull_replica_test_add_docs_shard1_replica_p2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 106971 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 106975 INFO  (qtp1353079362-775) [n:127.0.0.1:60557_solr 
c:pull_replica_test_add_docs s:shard1 r:core_node3 
x:pull_replica_test_add_docs_shard1_replica_p2] o.a.s.c.S.Request 
[pull_replica_test_add_docs_shard1_replica_p2]  webapp=/solr 
path=/admin/plugins params={qt=/admin/plugins&stats=true&wt=javabin&version=2} 
status=0 QTime=3
   [junit4]   2> 106975 INFO  
(TEST-TestPullReplica.testAddDocs-seed#[3EA8302BDC0DCB1D]) [    ] 
o.a.s.c.TestPullReplica tearDown deleting collection
   [junit4]   2> 106975 INFO  (qtp1353079362-782) [n:127.0.0.1:60557_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=pull_replica_test_add_docs&action=DELETE&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 106989 INFO  
(OverseerThreadFactory-422-thread-2-processing-n:127.0.0.1:60557_solr) 
[n:127.0.0.1:60557_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing 
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
   [junit4]   2> 107004 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_n1, tag=null
   [junit4]   2> 107004 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@15b86f66: rootName = 
solr_60557, domain = solr.core.pull_replica_test_add_docs.shard1.replica_n1, 
service url = null, agent id = null] for registry 
solr.core.pull_replica_test_add_docs.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@35b375cc
   [junit4]   2> 107004 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_p1, tag=null
   [junit4]   2> 107004 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@a44b707: rootName = 
solr_60554, domain = solr.core.pull_replica_test_add_docs.shard1.replica_p1, 
service url = null, agent id = null] for registry 
solr.core.pull_replica_test_add_docs.shard1.replica_p1 / 
com.codahale.metrics.MetricRegistry@5982244d
   [junit4]   2> 107020 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.c.ZkController pull_replica_test_add_docs_shard1_replica_p1 stopping 
background replication from leader
   [junit4]   2> 107020 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@51711223
   [junit4]   2> 107020 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_p1, tag=1366364707
   [junit4]   2> 107020 INFO  (qtp1000326677-764) [n:127.0.0.1:60554_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_add_docs.shard1.leader, 
tag=1366364707
   [junit4]   2> 107035 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_n1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@725a8287
   [junit4]   2> 107035 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_n1, tag=1918534279
   [junit4]   2> 107035 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_add_docs.shard1.leader, 
tag=1918534279
   [junit4]   2> 107042 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_p2, tag=null
   [junit4]   2> 107042 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5bfa4b57: rootName = 
solr_60557, domain = solr.core.pull_replica_test_add_docs.shard1.replica_p2, 
service url = null, agent id = null] for registry 
solr.core.pull_replica_test_add_docs.shard1.replica_p2 / 
com.codahale.metrics.MetricRegistry@2e806827
   [junit4]   2> 107059 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.c.ZkController pull_replica_test_add_docs_shard1_replica_p2 stopping 
background replication from leader
   [junit4]   2> 107060 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.c.SolrCore [pull_replica_test_add_docs_shard1_replica_p2]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@19f1e619
   [junit4]   2> 107060 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.pull_replica_test_add_docs.shard1.replica_p2, tag=435283481
   [junit4]   2> 107060 INFO  (qtp1353079362-783) [n:127.0.0.1:60557_solr    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.pull_replica_test_add_docs.shard1.leader, tag=435283481
   [junit4]   2> 107062 INFO  (qtp1353079362-781) [n:127.0.0.1:60557_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={deleteInstanceDir=true&core=pull_replica_test_add_docs_shard1_

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

.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/collections/cdcr-target/state.json] for collection 
[cdcr-target] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1986422 INFO  (coreCloseExecutor-8233-thread-1) 
[n:127.0.0.1:59572_solr c:cdcr-target s:shard1 r:core_node1 
x:cdcr-target_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.cdcr-target.shard1.leader, tag=1669771377
   [junit4]   2> 1986422 INFO  (coreCloseExecutor-8233-thread-1) 
[n:127.0.0.1:59572_solr c:cdcr-target s:shard1 r:core_node1 
x:cdcr-target_shard1_replica_n1] o.a.s.h.CdcrRequestHandler Solr core is being 
closed - shutting down CDCR handler @ cdcr-target:shard1
   [junit4]   2> 1986424 INFO  (jetty-closer-4957-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98572438186033155-127.0.0.1:59572_solr-n_0000000000) closing
   [junit4]   2> 1986424 INFO  
(OverseerStateUpdate-98572438186033155-127.0.0.1:59572_solr-n_0000000000) 
[n:127.0.0.1:59572_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:59572_solr
   [junit4]   2> 1987924 WARN  
(zkCallback-4963-thread-2-processing-n:127.0.0.1:59572_solr) 
[n:127.0.0.1:59572_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1987924 INFO  (jetty-closer-4957-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3be797a5{/solr,null,UNAVAILABLE}
   [junit4]   2> 1987925 ERROR 
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[3EA8302BDC0DCB1D]) 
[    ] 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> 1987926 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[3EA8302BDC0DCB1D]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59568 59568
   [junit4]   2> 1987928 INFO  (Thread-4085) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:59568 59568
   [junit4]   2> 1987928 WARN  (Thread-4085) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/configs/cdcr-target/managed-schema
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2>        3       
/solr/collections/cdcr-target/leaders/shard1/leader
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/collections/cdcr-target/state.json
   [junit4]   2>        4       /solr/collections/cdcr-target/cdcr/state/process
   [junit4]   2>        3       /solr/collections/cdcr-target/cdcr/state/buffer
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2> 
   [junit4]   2> 1987928 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[3EA8302BDC0DCB1D]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testBootstrapWithSourceCluster
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CdcrBootstrapTest_3EA8302BDC0DCB1D-001
   [junit4]   2> Aug 30, 2017 12:27:35 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{xyz=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=MockRandom)}, 
docValues:{_version_=DocValuesFormat(name=Lucene70), 
xyz=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Memory)}, 
maxPointsInLeafNode=1098, maxMBSortInHeap=7.47344127196835, 
sim=RandomSimilarity(queryNorm=false): {}, locale=he, 
timezone=Africa/Ouagadougou
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=196690816,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [ShardSplitTest, 
SuggestComponentContextFilterQueryTest, ClassificationUpdateProcessorTest, 
TestSchemalessBufferedUpdates, MinimalSchemaTest, TestLFUCache, 
TestStressReorder, TestCloudJSONFacetJoinDomain, SolrTestCaseJ4Test, 
XsltUpdateRequestHandlerTest, SliceStateTest, TestFaceting, TestSearcherReuse, 
TestHttpShardHandlerFactory, ClusterStateUpdateTest, ForceLeaderTest, 
ReturnFieldsTest, SparseHLLTest, CSVRequestHandlerTest, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TestLazyCores, 
DistributedFacetPivotLongTailTest, TestMacros, DistributedFacetPivotSmallTest, 
TestIndexingPerformance, NumericFieldsTest, SpellCheckCollatorWithCollapseTest, 
BasicDistributedZkTest, IndexSchemaTest, TestStandardQParsers, 
ChaosMonkeyNothingIsSafeTest, VersionInfoTest, 
AtomicUpdateProcessorFactoryTest, CoreSorterTest, 
TestImpersonationWithHadoopAuth, SolrCLIZkUtilsTest, HdfsLockFactoryTest, 
TestConfigOverlay, TestConfigsApi, URLClassifyProcessorTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, DeleteShardTest, 
TestStressCloudBlindAtomicUpdates, RequestLoggingTest, TestSolrDeletionPolicy2, 
TestSegmentSorting, TestRTimerTree, MissingSegmentRecoveryTest, 
TestSolrCoreParser, TestZkAclsWithHadoopAuth, MoveReplicaHDFSUlogDirTest, 
TestScoreJoinQPScore, DistributedSuggestComponentTest, TestSolrCoreProperties, 
TestStressRecovery, TestStressLiveNodes, TestShardHandlerFactory, 
RecoveryZkTest, AnalysisAfterCoreReloadTest, BlockJoinFacetRandomTest, 
SolrXmlInZkTest, TestHashPartitioner, ClusterStateTest, AliasIntegrationTest, 
ExplicitHLLTest, TestUtils, SpatialRPTFieldTypeTest, CircularListTest, 
SegmentsInfoRequestHandlerTest, TestLegacyField, DocValuesTest, 
HdfsSyncSliceTest, TestHdfsUpdateLog, TestQuerySenderListener, TestSQLHandler, 
TestCloudManagedSchema, DistribJoinFromCollectionTest, 
TestMiniSolrCloudCluster, ChangedSchemaMergeTest, InfixSuggestersTest, 
TestXmlQParserPlugin, RequiredFieldsTest, TestExtendedDismaxParser, 
TestTolerantUpdateProcessorCloud, LeaderElectionTest, DistanceFunctionTest, 
TestDistributedSearch, TestQueryWrapperFilter, ZkStateWriterTest, 
SimpleFacetsTest, RegexBoostProcessorTest, HdfsChaosMonkeySafeLeaderTest, 
TestUpdate, SpatialFilterTest, CdcrUpdateLogTest, TestFieldCacheSort, 
OverseerTest, UniqFieldsUpdateProcessorFactoryTest, SolrInfoBeanTest, 
TestExactStatsCache, TestClusterStateMutator, EnumFieldTest, PrimUtilsTest, 
TestTolerantSearch, LeaderFailureAfterFreshStartTest, 
ExitableDirectoryReaderTest, SoftAutoCommitTest, CloudMLTQParserTest, 
TestClusterProperties, CleanupOldIndexTest, CollectionTooManyReplicasTest, 
TestReplicationHandler, TestFieldTypeResource, CollectionReloadTest, 
TestPayloadCheckQParserPlugin, MultiTermTest, WrapperMergePolicyFactoryTest, 
TestComplexPhraseLeadingWildcard, ResponseLogComponentTest, 
TestFoldingMultitermQuery, TestFreeTextSuggestions, TestIBSimilarityFactory, 
UUIDFieldTest, SolrCoreTest, DateMathParserTest, QueryElevationComponentTest, 
ConnectionReuseTest, TestReversedWildcardFilterFactory, TestMissingGroups, 
TestLeaderElectionZkExpiry, TestDocBasedVersionConstraints, 
TestFilteredDocIdSet, CachingDirectoryFactoryTest, 
DistributedQueryComponentCustomSortTest, TestBlendedInfixSuggestions, 
HardAutoCommitTest, CollectionsAPISolrJTest, DirectUpdateHandlerOptimizeTest, 
TestHalfAndHalfDocValues, TestJmxIntegration, FieldAnalysisRequestHandlerTest, 
TestInfoStreamLogging, TestHdfsCloudBackupRestore, HdfsNNFailoverTest, 
TestDFRSimilarityFactory, DefaultValueUpdateProcessorTest, 
TestAtomicUpdateErrorCases, ParsingFieldUpdateProcessorsTest, 
TestSha256AuthenticationProvider, AsyncCallRequestStatusResponseTest, 
PropertiesRequestHandlerTest, LargeFieldTest, 
PeerSyncWithIndexFingerprintCachingTest, TestFieldCacheVsDocValues, 
QueryParsingTest, TestStressVersions, DirectSolrConnectionTest, 
ScriptEngineTest, SharedFSAutoReplicaFailoverUtilsTest, TestPseudoReturnFields, 
TestCursorMarkWithoutUniqueKey, TestOmitPositions, TestDownShardTolerantSearch, 
TestSlowCompositeReaderWrapper, SuggesterWFSTTest, 
TestDeleteCollectionOnDownNodes, TestSubQueryTransformer, SortByFunctionTest, 
UnloadDistributedZkTest, TestAddFieldRealTimeGet, LeaderElectionContextKeyTest, 
TestCloudPseudoReturnFields, PeerSyncTest, TestFieldCache, 
TestJavabinTupleStreamParser, TestPhraseSuggestions, OverseerRolesTest, 
TestLegacyNumericUtils, TestCoreContainer, ShardRoutingTest, 
TestRandomDVFaceting, AutoCommitTest, ZkControllerTest, TestRealTimeGet, 
TestJoin, DistributedTermsComponentTest, TestGroupingSearch, 
ConvertedLegacyTest, DirectUpdateHandlerTest, ShowFileRequestHandlerTest, 
SimplePostToolTest, TestCoreDiscovery, SuggesterTest, TestCSVLoader, 
WordBreakSolrSpellCheckerTest, TestWordDelimiterFilterFactory, 
TestRemoteStreaming, TestSolrDeletionPolicy1, DebugComponentTest, 
IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, 
DirectSolrSpellCheckerTest, PrimitiveFieldTypeTest, 
XmlUpdateRequestHandlerTest, RequestHandlersTest, TestValueSourceCache, 
PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest, 
FastVectorHighlighterTest, TestCollationField, MBeansHandlerTest, 
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, 
PingRequestHandlerTest, HighlighterConfigTest, UpdateParamsTest, 
AlternateDirectoryTest, TestQuerySenderNoQuery, TestBinaryField, 
TestSearchPerf, OutputWriterTest, TestPostingsSolrHighlighter, 
TestCodecSupport, TestLMDirichletSimilarityFactory, TestFastWriter, 
ResourceLoaderTest, OpenExchangeRatesOrgProviderTest, 
TestSuggestSpellingConverter, DOMUtilTest, DistributedMLTComponentTest, 
TestCrossCoreJoin, TestDistributedMissingSort, TestHighlightDedupGrouping, 
TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, 
ActionThrottleTest, AssignTest, CdcrBootstrapTest]
   [junit4] Completed [493/729 (2!)] on J0 in 159.56s, 3 tests, 1 failure <<< 
FAILURES!

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

Reply via email to