Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Linux/392/
Java: 32bit/jdk1.8.0_144 -client -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 3 in http://127.0.0.1:33153/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 3 in http://127.0.0.1:33153/solr
        at 
__randomizedtesting.SeedInfo.seed([E90352E52580FD13:28F32B4908D037B4]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:868)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:559)
        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 11674 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestTlogReplica
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/init-core-data-001
   [junit4]   2> 624997 WARN  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 624997 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 624999 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 625000 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001
   [junit4]   2> 625000 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 625000 INFO  (Thread-1706) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 625000 INFO  (Thread-1706) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 625002 ERROR (Thread-1706) [    ] 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> 625100 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:42439
   [junit4]   2> 625107 INFO  (jetty-launcher-919-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 625107 INFO  (jetty-launcher-919-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 625108 INFO  (jetty-launcher-919-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1672a7b{/solr,null,AVAILABLE}
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1afa740{HTTP/1.1,[http/1.1]}{127.0.0.1:45841}
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.e.j.s.Server Started @629007ms
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45841}
   [junit4]   2> 625110 ERROR (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 625110 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-29T21:28:48.409Z
   [junit4]   2> 625111 INFO  (jetty-launcher-919-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@55cb56{/solr,null,AVAILABLE}
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@41e83e{HTTP/1.1,[http/1.1]}{127.0.0.1:33153}
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.e.j.s.Server Started @629009ms
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=33153}
   [junit4]   2> 625112 ERROR (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 625112 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-29T21:28:48.411Z
   [junit4]   2> 625124 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 625130 INFO  (jetty-launcher-919-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42439/solr
   [junit4]   2> 625133 INFO  (jetty-launcher-919-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42439/solr
   [junit4]   2> 625203 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 625204 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:33153_solr
   [junit4]   2> 625205 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.Overseer Overseer 
(id=98744436542668806-127.0.0.1:33153_solr-n_0000000000) starting
   [junit4]   2> 625207 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 625208 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45841_solr
   [junit4]   2> 625209 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 625210 INFO  
(zkCallback-931-thread-1-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 625216 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33153_solr
   [junit4]   2> 625221 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 625224 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 625412 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33153.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625423 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33153.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625424 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33153.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625425 INFO  (jetty-launcher-919-thread-1) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/.
   [junit4]   2> 625497 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45841.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625506 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45841.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625506 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45841.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 625507 INFO  (jetty-launcher-919-thread-2) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/.
   [junit4]   2> 625555 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 0x15ecf8ab7ac0007, 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> 625559 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 625559 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42439/solr ready
   [junit4]   2> 625561 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.TestTlogReplica Using legacyCloud?: false
   [junit4]   2> 625563 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_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> 625564 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_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=1
   [junit4]   2> 625575 INFO  
(TEST-TestTlogReplica.testCreateDelete-seed#[E90352E52580FD13]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCreateDelete { 
seed=[E90352E52580FD13:F213A3A9D3700523]}
   [junit4]   2> 625579 INFO  
(OverseerThreadFactory-2404-thread-1-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
tlog_replica_test_create_delete
   [junit4]   2> 625579 WARN  
(OverseerThreadFactory-2404-thread-1-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.CreateCollectionCmd Specified number of 
replicas of 4 on collection tlog_replica_test_create_delete 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> 625684 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard1_replica_t1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:45841/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625686 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard1_replica_t2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33153/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625687 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard1_replica_t3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:45841/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625688 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard1_replica_t4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33153/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625689 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard2_replica_t1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:45841/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625691 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard2_replica_t2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33153/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625691 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard2_replica_t3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:45841/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625692 INFO  
(OverseerStateUpdate-98744436542668806-127.0.0.1:33153_solr-n_0000000000) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_create_delete",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"tlog_replica_test_create_delete_shard2_replica_t4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:33153/solr";,
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 625894 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t2&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625894 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t1&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625894 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard2_replica_t2&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625895 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 625895 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 625895 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard2_replica_t1&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625896 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t4&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625904 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t3&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625908 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard2_replica_t3&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 625910 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard2_replica_t4&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 626012 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 626012 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 626908 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626910 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626922 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626922 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626929 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626930 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626950 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard1_replica_t4] Schema name=minimal
   [junit4]   2> 626951 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626954 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard1_replica_t2] Schema name=minimal
   [junit4]   2> 626958 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard2_replica_t1] Schema name=minimal
   [junit4]   2> 626961 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626961 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard1_replica_t2' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626961 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626962 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard2_replica_t1' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626964 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 7.0.0
   [junit4]   2> 626966 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard1_replica_t1] Schema name=minimal
   [junit4]   2> 626967 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626967 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard1_replica_t4' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626968 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard1_replica_t3] Schema name=minimal
   [junit4]   2> 626969 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626969 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard1_replica_t1' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626969 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_33153.solr.core.tlog_replica_test_create_delete.shard1.replica_t4' 
(registry 'solr.core.tlog_replica_test_create_delete.shard1.replica_t4') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626970 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_45841.solr.core.tlog_replica_test_create_delete.shard1.replica_t1' 
(registry 'solr.core.tlog_replica_test_create_delete.shard1.replica_t1') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626970 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626970 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard1_replica_t1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/tlog_replica_test_create_delete_shard1_replica_t1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/./tlog_replica_test_create_delete_shard1_replica_t1/data/]
   [junit4]   2> 626970 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_45841.solr.core.tlog_replica_test_create_delete.shard2.replica_t1' 
(registry 'solr.core.tlog_replica_test_create_delete.shard2.replica_t1') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626971 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626971 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626971 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard2_replica_t1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/tlog_replica_test_create_delete_shard2_replica_t1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/./tlog_replica_test_create_delete_shard2_replica_t1/data/]
   [junit4]   2> 626972 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard2_replica_t3] Schema name=minimal
   [junit4]   2> 626972 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626972 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard1_replica_t4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/tlog_replica_test_create_delete_shard1_replica_t4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/./tlog_replica_test_create_delete_shard1_replica_t4/data/]
   [junit4]   2> 626970 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_33153.solr.core.tlog_replica_test_create_delete.shard1.replica_t2' 
(registry 'solr.core.tlog_replica_test_create_delete.shard1.replica_t2') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626974 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626974 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard1_replica_t2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/tlog_replica_test_create_delete_shard1_replica_t2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/./tlog_replica_test_create_delete_shard1_replica_t2/data/]
   [junit4]   2> 626972 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard2_replica_t2] Schema name=minimal
   [junit4]   2> 626975 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626975 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard2_replica_t3' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626975 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_45841.solr.core.tlog_replica_test_create_delete.shard2.replica_t3' 
(registry 'solr.core.tlog_replica_test_create_delete.shard2.replica_t3') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626976 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626976 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard2_replica_t3] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/tlog_replica_test_create_delete_shard2_replica_t3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/./tlog_replica_test_create_delete_shard2_replica_t3/data/]
   [junit4]   2> 626971 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard1_replica_t3' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626977 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_45841.solr.core.tlog_replica_test_create_delete.shard1.replica_t3' 
(registry 'solr.core.tlog_replica_test_create_delete.shard1.replica_t3') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626977 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626977 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard1_replica_t3] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/tlog_replica_test_create_delete_shard1_replica_t3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node2/./tlog_replica_test_create_delete_shard1_replica_t3/data/]
   [junit4]   2> 626978 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626978 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard2_replica_t2' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626982 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.s.IndexSchema 
[tlog_replica_test_create_delete_shard2_replica_t4] Schema name=minimal
   [junit4]   2> 626984 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 626985 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_create_delete_shard2_replica_t4' using 
configuration from collection tlog_replica_test_create_delete, trusted=true
   [junit4]   2> 626985 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_33153.solr.core.tlog_replica_test_create_delete.shard2.replica_t4' 
(registry 'solr.core.tlog_replica_test_create_delete.shard2.replica_t4') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626985 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 626985 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard2_replica_t4] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/tlog_replica_test_create_delete_shard2_replica_t4],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/./tlog_replica_test_create_delete_shard2_replica_t4/data/]
   [junit4]   2> 626988 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_33153.solr.core.tlog_replica_test_create_delete.shard2.replica_t2' 
(registry 'solr.core.tlog_replica_test_create_delete.shard2.replica_t2') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f670e5
   [junit4]   2> 626995 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 627021 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.SolrCore 
[[tlog_replica_test_create_delete_shard2_replica_t2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/tlog_replica_test_create_delete_shard2_replica_t2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001/tempDir-001/node1/./tlog_replica_test_create_delete_shard2_replica_t2/data/]
   [junit4]   2> 627226 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627226 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627227 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627227 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627234 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@d61714[tlog_replica_test_create_delete_shard1_replica_t2] 
main]
   [junit4]   2> 627237 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627238 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627246 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627257 INFO  
(searcherExecutor-2409-thread-1-processing-n:127.0.0.1:33153_solr 
x:tlog_replica_test_create_delete_shard1_replica_t2 s:shard1 
c:tlog_replica_test_create_delete r:core_node2) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard1_replica_t2] Registered new searcher 
Searcher@d61714[tlog_replica_test_create_delete_shard1_replica_t2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627258 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987049336832
   [junit4]   2> 627264 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627264 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627269 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=4 found=1 timeoutin=9995ms
   [junit4]   2> 627270 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627270 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627276 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627276 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627277 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627277 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627279 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1fb947[tlog_replica_test_create_delete_shard1_replica_t4] 
main]
   [junit4]   2> 627280 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627282 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627283 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627283 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987075551232
   [junit4]   2> 627283 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@2b5d86[tlog_replica_test_create_delete_shard1_replica_t3] 
main]
   [junit4]   2> 627289 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627290 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627292 INFO  
(searcherExecutor-2411-thread-1-processing-n:127.0.0.1:33153_solr 
x:tlog_replica_test_create_delete_shard1_replica_t4 s:shard1 
c:tlog_replica_test_create_delete r:core_node4) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard1_replica_t4] Registered new searcher 
Searcher@1fb947[tlog_replica_test_create_delete_shard1_replica_t4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627293 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627293 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627294 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627294 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627295 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627300 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@c08797[tlog_replica_test_create_delete_shard1_replica_t1] 
main]
   [junit4]   2> 627300 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627300 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627301 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627301 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627301 INFO  
(searcherExecutor-2414-thread-1-processing-n:127.0.0.1:45841_solr 
x:tlog_replica_test_create_delete_shard1_replica_t3 s:shard1 
c:tlog_replica_test_create_delete r:core_node3) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard1_replica_t3] Registered new searcher 
Searcher@2b5d86[tlog_replica_test_create_delete_shard1_replica_t3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627301 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987094425600
   [junit4]   2> 627302 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627302 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627302 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627303 INFO  
(searcherExecutor-2412-thread-1-processing-n:127.0.0.1:45841_solr 
x:tlog_replica_test_create_delete_shard1_replica_t1 s:shard1 
c:tlog_replica_test_create_delete r:core_node1) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard1_replica_t1] Registered new searcher 
Searcher@c08797[tlog_replica_test_create_delete_shard1_replica_t1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627304 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987097571328
   [junit4]   2> 627532 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@c8d04d[tlog_replica_test_create_delete_shard2_replica_t1] 
main]
   [junit4]   2> 627537 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627537 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627538 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627538 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627538 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627538 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627539 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627539 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627540 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627541 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627541 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627542 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1bcc2b1[tlog_replica_test_create_delete_shard2_replica_t2] 
main]
   [junit4]   2> 627542 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627543 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@619058[tlog_replica_test_create_delete_shard2_replica_t3] 
main]
   [junit4]   2> 627543 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627544 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627544 INFO  
(searcherExecutor-2410-thread-1-processing-n:127.0.0.1:45841_solr 
x:tlog_replica_test_create_delete_shard2_replica_t1 s:shard2 
c:tlog_replica_test_create_delete r:core_node5) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard2_replica_t1] Registered new searcher 
Searcher@c8d04d[tlog_replica_test_create_delete_shard2_replica_t1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627544 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627544 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987349229568
   [junit4]   2> 627545 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627545 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627545 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627546 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 627546 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 627547 INFO  
(searcherExecutor-2413-thread-1-processing-n:127.0.0.1:45841_solr 
x:tlog_replica_test_create_delete_shard2_replica_t3 s:shard2 
c:tlog_replica_test_create_delete r:core_node7) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard2_replica_t3] Registered new searcher 
Searcher@619058[tlog_replica_test_create_delete_shard2_replica_t3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627547 INFO  (qtp11131118-6016) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987352375296
   [junit4]   2> 627548 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 627548 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 627549 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627551 INFO  
(searcherExecutor-2415-thread-1-processing-n:127.0.0.1:33153_solr 
x:tlog_replica_test_create_delete_shard2_replica_t2 s:shard2 
c:tlog_replica_test_create_delete r:core_node6) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard2_replica_t2] Registered new searcher 
Searcher@1bcc2b1[tlog_replica_test_create_delete_shard2_replica_t2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627551 INFO  (qtp28723918-6015) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987356569600
   [junit4]   2> 627551 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1d92dfb[tlog_replica_test_create_delete_shard2_replica_t4] 
main]
   [junit4]   2> 627552 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=4 found=2 timeoutin=9999ms
   [junit4]   2> 627553 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 627553 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 627554 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 627555 INFO  
(searcherExecutor-2416-thread-1-processing-n:127.0.0.1:33153_solr 
x:tlog_replica_test_create_delete_shard2_replica_t4 s:shard2 
c:tlog_replica_test_create_delete r:core_node8) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.SolrCore 
[tlog_replica_test_create_delete_shard2_replica_t4] Registered new searcher 
Searcher@1d92dfb[tlog_replica_test_create_delete_shard2_replica_t4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 627555 INFO  (qtp28723918-6080) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1579910987360763904
   [junit4]   2> 627653 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627653 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627769 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 627769 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 627769 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard1_replica_t2/
   [junit4]   2> 627770 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_create_delete_shard1_replica_t2 
url=http://127.0.0.1:33153/solr START 
replicas=[http://127.0.0.1:45841/solr/tlog_replica_test_create_delete_shard1_replica_t1/,
 
http://127.0.0.1:45841/solr/tlog_replica_test_create_delete_shard1_replica_t3/, 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard1_replica_t4/] 
nUpdates=100
   [junit4]   2> 627770 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_create_delete_shard1_replica_t2 
url=http://127.0.0.1:33153/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 627773 INFO  (qtp28723918-6011) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard1_replica_t4]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 627773 INFO  (qtp11131118-6083) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard1_replica_t1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 627773 INFO  (qtp11131118-6020) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard1_replica_t3]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 627773 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 627773 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 627773 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 627773 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.ZkController 
tlog_replica_test_create_delete_shard1_replica_t2 stopping background 
replication from leader
   [junit4]   2> 627775 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard1_replica_t2/ 
shard1
   [junit4]   2> 627877 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627877 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 627926 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 627927 INFO  (qtp28723918-6025) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t2&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=2033
   [junit4]   2> 628029 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628029 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628052 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 628052 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 628052 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:45841/solr/tlog_replica_test_create_delete_shard2_replica_t1/
   [junit4]   2> 628053 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_create_delete_shard2_replica_t1 
url=http://127.0.0.1:45841/solr START 
replicas=[http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard2_replica_t2/,
 
http://127.0.0.1:45841/solr/tlog_replica_test_create_delete_shard2_replica_t3/, 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard2_replica_t4/] 
nUpdates=100
   [junit4]   2> 628053 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_create_delete_shard2_replica_t1 
url=http://127.0.0.1:45841/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 628055 INFO  (qtp28723918-6013) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node6 
x:tlog_replica_test_create_delete_shard2_replica_t2] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard2_replica_t2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 628055 INFO  (qtp11131118-6021) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node7 
x:tlog_replica_test_create_delete_shard2_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard2_replica_t3]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 628056 INFO  (qtp28723918-6026) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node8 
x:tlog_replica_test_create_delete_shard2_replica_t4] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard2_replica_t4]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 628056 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 628056 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 628056 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 628057 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.ZkController 
tlog_replica_test_create_delete_shard2_replica_t1 stopping background 
replication from leader
   [junit4]   2> 628059 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:45841/solr/tlog_replica_test_create_delete_shard2_replica_t1/ 
shard2
   [junit4]   2> 628162 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628162 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628210 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 628211 INFO  (qtp11131118-6012) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard2 r:core_node5 
x:tlog_replica_test_create_delete_shard2_replica_t1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard2_replica_t1&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard2&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=2316
   [junit4]   2> 628298 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.c.ZkController 
tlog_replica_test_create_delete_shard1_replica_t4 starting background 
replication from leader
   [junit4]   2> 628298 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:03
   [junit4]   2> 628301 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.ReplicationHandler 
Poll scheduled at an interval of 3000ms
   [junit4]   2> 628301 INFO  (indexFetcher-2450-thread-1) 
[n:127.0.0.1:33153_solr c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.IndexFetcher 
Updated masterUrl to 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard1_replica_t2/
   [junit4]   2> 628302 INFO  (qtp28723918-6009) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t4&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=2405
   [junit4]   2> 628302 INFO  (qtp28723918-6082) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard1_replica_t2]  webapp=/solr 
path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 628302 INFO  (indexFetcher-2450-thread-1) 
[n:127.0.0.1:33153_solr c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.IndexFetcher 
Master's generation: 1
   [junit4]   2> 628302 INFO  (indexFetcher-2450-thread-1) 
[n:127.0.0.1:33153_solr c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.IndexFetcher 
Master's version: 0
   [junit4]   2> 628302 INFO  (indexFetcher-2450-thread-1) 
[n:127.0.0.1:33153_solr c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.IndexFetcher 
Slave's generation: 1
   [junit4]   2> 628302 INFO  (indexFetcher-2450-thread-1) 
[n:127.0.0.1:33153_solr c:tlog_replica_test_create_delete s:shard1 r:core_node4 
x:tlog_replica_test_create_delete_shard1_replica_t4] o.a.s.h.IndexFetcher 
Slave's version: 0
   [junit4]   2> 628305 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.c.ZkController 
tlog_replica_test_create_delete_shard1_replica_t3 starting background 
replication from leader
   [junit4]   2> 628305 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] 
o.a.s.c.ReplicateFromLeader Will start replication from leader with poll 
interval: 00:00:03
   [junit4]   2> 628306 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.ReplicationHandler 
Poll scheduled at an interval of 3000ms
   [junit4]   2> 628306 INFO  (indexFetcher-2452-thread-1) 
[n:127.0.0.1:45841_solr c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.IndexFetcher 
Updated masterUrl to 
http://127.0.0.1:33153/solr/tlog_replica_test_create_delete_shard1_replica_t2/
   [junit4]   2> 628307 INFO  (qtp28723918-6011) [n:127.0.0.1:33153_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node2 
x:tlog_replica_test_create_delete_shard1_replica_t2] o.a.s.c.S.Request 
[tlog_replica_test_create_delete_shard1_replica_t2]  webapp=/solr 
path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 628307 INFO  (indexFetcher-2452-thread-1) 
[n:127.0.0.1:45841_solr c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.IndexFetcher 
Master's generation: 1
   [junit4]   2> 628307 INFO  (indexFetcher-2452-thread-1) 
[n:127.0.0.1:45841_solr c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.IndexFetcher 
Master's version: 0
   [junit4]   2> 628307 INFO  (indexFetcher-2452-thread-1) 
[n:127.0.0.1:45841_solr c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.IndexFetcher 
Slave's generation: 1
   [junit4]   2> 628307 INFO  (indexFetcher-2452-thread-1) 
[n:127.0.0.1:45841_solr c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.h.IndexFetcher 
Slave's version: 0
   [junit4]   2> 628307 INFO  (qtp11131118-6014) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node3 
x:tlog_replica_test_create_delete_shard1_replica_t3] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_create_delete_shard1_replica_t3&action=CREATE&numShards=2&collection=tlog_replica_test_create_delete&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=2403
   [junit4]   2> 628409 INFO  
(zkCallback-930-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628409 INFO  
(zkCallback-931-thread-2-processing-n:127.0.0.1:33153_solr) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_create_delete/state.json] for collection 
[tlog_replica_test_create_delete] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 628542 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_test_create_delete s:shard1 r:core_node1 
x:tlog_replica_test_create_delete_shard1_replica_t1] o.a.s.c.ZkController 
tlog_replica_test_create_delete_shard1_replica_t1 starting background 
replication from leader
   [junit4]   2> 628542 INFO  (qtp11131118-6010) [n:127.0.0.1:45841_solr 
c:tlog_replica_tes

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

TTP/1.1,[http/1.1]}{127.0.0.1:33153}
   [junit4]   2> 727690 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=32422802
   [junit4]   2> 727690 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 727690 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e4964d: rootName = 
solr_33153, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1412971
   [junit4]   2> 727691 INFO  (jetty-closer-920-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@1d82c3b{HTTP/1.1,[http/1.1]}{127.0.0.1:45841}
   [junit4]   2> 727693 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1422148
   [junit4]   2> 727693 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 727693 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a47027: rootName = 
solr_45841, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1a45578
   [junit4]   2> 727695 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 727695 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5cedc4: rootName = 
solr_33153, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@920ec9
   [junit4]   2> 727700 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 727700 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1937b21: rootName = 
solr_33153, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@14412ff
   [junit4]   2> 727700 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 727700 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1466c3a: rootName = 
solr_45841, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@920ec9
   [junit4]   2> 727700 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 727701 INFO  (jetty-closer-920-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98744436542668823-127.0.0.1:33153_solr-n_0000000006) closing
   [junit4]   2> 727701 INFO  
(OverseerStateUpdate-98744436542668823-127.0.0.1:33153_solr-n_0000000006) 
[n:127.0.0.1:33153_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:33153_solr
   [junit4]   2> 727702 INFO  
(zkCallback-980-thread-2-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (1)
   [junit4]   2> 727702 INFO  
(zkCallback-980-thread-1-processing-n:127.0.0.1:45841_solr) 
[n:127.0.0.1:45841_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:45841_solr
   [junit4]   2> 727703 INFO  (jetty-closer-920-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@a47c63{/solr,null,UNAVAILABLE}
   [junit4]   2> 727706 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 727706 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@10fbe3e: rootName = 
solr_45841, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@14412ff
   [junit4]   2> 727707 INFO  (jetty-closer-920-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 727708 INFO  (jetty-closer-920-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@edb037{/solr,null,UNAVAILABLE}
   [junit4]   2> 727711 ERROR 
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 727712 INFO  
(SUITE-TestTlogReplica-seed#[E90352E52580FD13]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:42439 42439
   [junit4]   2> 742731 INFO  (Thread-1706) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:42439 42439
   [junit4]   2> 742732 WARN  (Thread-1706) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        33      /solr/configs/conf
   [junit4]   2>        9       /solr/aliases.json
   [junit4]   2>        8       /solr/security.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        25      
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
   [junit4]   2>        25      
/solr/collections/tlog_replica_test_basic_leader_election/state.json
   [junit4]   2>        24      
/solr/collections/tlog_replica_test_kill_leader/state.json
   [junit4]   2>        24      
/solr/collections/tlog_replica_test_remove_leader/state.json
   [junit4]   2>        23      
/solr/collections/tlog_replica_test_kill_tlog_replica/state.json
   [junit4]   2>        23      
/solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
   [junit4]   2>        22      
/solr/collections/tlog_replica_test_recovery/state.json
   [junit4]   2>        16      
/solr/collections/tlog_replica_test_create_delete/state.json
   [junit4]   2>        15      
/solr/collections/tlog_replica_test_add_docs/state.json
   [junit4]   2>        15      
/solr/collections/tlog_replica_test_real_time_get/state.json
   [junit4]   2>        15      
/solr/collections/tlog_replica_test_delete_by_id/state.json
   [junit4]   2>        13      
/solr/collections/tlog_replica_test_only_leader_indexes/state.json
   [junit4]   2>        9       /solr/clusterstate.json
   [junit4]   2>        9       /solr/clusterprops.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/98744436542668805-core_node5-n_0000000000
   [junit4]   2>        3       
/solr/overseer_elect/election/98744436542668814-127.0.0.1:45841_solr-n_0000000003
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/98744436542668814-core_node1-n_0000000000
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/98744436542668806-core_node4-n_0000000001
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/98744436542668806-core_node2-n_0000000000
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/98744436542668806-core_node6-n_0000000002
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        9       /solr/collections
   [junit4]   2>        5       /solr/overseer/queue
   [junit4]   2>        5       /solr/overseer/collection-queue-work
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.0-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_E90352E52580FD13-001
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=true): {}, locale=es-PE, 
timezone=America/Winnipeg
   [junit4]   2> NOTE: Linux 4.10.0-33-generic i386/Oracle Corporation 
1.8.0_144 (32-bit)/cpus=8,threads=1,free=143561136,total=319553536
   [junit4]   2> NOTE: All tests run in this JVM: [TestNumericRangeQuery32, 
TestLeaderElectionZkExpiry, TestAnalyzeInfixSuggestions, FacetPivotSmallTest, 
TestSolrCoreProperties, SimplePostToolTest, CdcrVersionReplicationTest, 
TestSort, AutoCommitTest, ClusterStateTest, TestSuggestSpellingConverter, 
CopyFieldTest, MoveReplicaTest, HdfsWriteToMultipleCollectionsTest, TestMacros, 
TestStressReorder, HdfsRecoveryZkTest, TestClusterProperties, 
SolrJmxReporterCloudTest, SecurityConfHandlerTest, SaslZkACLProviderTest, 
TestClassNameShortening, BooleanFieldTest, TestPullReplica, 
DocValuesNotIndexedTest, TestNoOpRegenerator, TestApiFramework, 
TestFreeTextSuggestions, OverseerTaskQueueTest, LeaderElectionContextKeyTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestPushWriter, SortSpecParsingTest, 
PingRequestHandlerTest, SolrCloudExampleTest, DirectUpdateHandlerOptimizeTest, 
TestSchemaResource, BasicDistributedZk2Test, TestFoldingMultitermQuery, 
TestReload, URLClassifyProcessorTest, LargeFieldTest, 
AsyncCallRequestStatusResponseTest, TestEmbeddedSolrServerSchemaAPI, 
SpatialRPTFieldTypeTest, TestSystemCollAutoCreate, RestartWhileUpdatingTest, 
TestQuerySenderListener, TestSmileRequest, SolrCoreMetricManagerTest, 
HdfsDirectoryFactoryTest, TestOrdValues, TestMaxScoreQueryParser, 
TestLMJelinekMercerSimilarityFactory, LeaderInitiatedRecoveryOnCommitTest, 
TestComplexPhraseLeadingWildcard, TestTrie, SearchHandlerTest, 
TestAuthorizationFramework, TestMiniSolrCloudClusterSSL, SuggesterTest, 
SharedFSAutoReplicaFailoverUtilsTest, GraphQueryTest, HardAutoCommitTest, 
ConfigSetsAPITest, TestTlogReplica]
   [junit4] Completed [229/730 (1!)] on J2 in 117.76s, 13 tests, 1 failure <<< 
FAILURES!

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

Reply via email to