Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/634/

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

Error Message:
Can not find doc 1 in https://127.0.0.1:41191/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 1 in https://127.0.0.1:41191/solr
        at 
__randomizedtesting.SeedInfo.seed([B099051AE6FE71E7:AE7637EADE553D97]:0)
        at org.junit.Assert.fail(Assert.java:89)
        at org.junit.Assert.assertTrue(Assert.java:42)
        at org.junit.Assert.assertNotNull(Assert.java:713)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:988)
        at 
org.apache.solr.cloud.TestTlogReplica.testRebalanceLeaders(TestTlogReplica.java:753)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 14107 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestTlogReplica
   [junit4]   2> 803764 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 803764 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 803765 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/data-dir-60-001
   [junit4]   2> 803765 WARN  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14
   [junit4]   2> 803765 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 803767 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 803769 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001
   [junit4]   2> 803769 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 803770 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 803770 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 803770 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 803870 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port: 37967
   [junit4]   2> 803870 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:37967
   [junit4]   2> 803870 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37967
   [junit4]   2> 803870 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 37967
   [junit4]   2> 803871 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 803876 INFO  (zkConnectionManagerCallback-6732-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 803876 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 803879 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 803880 INFO  (zkConnectionManagerCallback-6734-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 803880 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 803881 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 803882 INFO  (zkConnectionManagerCallback-6736-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 803882 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 803987 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_252-b09
   [junit4]   2> 803987 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 803987 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 1.8.0_252-b09
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@70bcfe44{/solr,null,AVAILABLE}
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 803993 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@d7882dd{SSL, (ssl, 
http/1.1)}{127.0.0.1:38135}
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6a722366{/solr,null,AVAILABLE}
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.s.Server Started @804020ms
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38135}
   [junit4]   2> 803994 ERROR (jetty-launcher-6737-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.7.0
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 803994 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-10-14T20:52:34.985Z
   [junit4]   2> 803995 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 803995 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@68476b05{SSL, (ssl, 
http/1.1)}{127.0.0.1:41191}
   [junit4]   2> 803995 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.s.Server Started @804021ms
   [junit4]   2> 803995 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41191}
   [junit4]   2> 803995 ERROR (jetty-launcher-6737-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 803995 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.7.0
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-10-14T20:52:34.987Z
   [junit4]   2> 803996 INFO  (zkConnectionManagerCallback-6739-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 803996 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 803997 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 803997 INFO  (zkConnectionManagerCallback-6741-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 803997 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 804001 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 804005 WARN  
(jetty-launcher-6737-thread-1-SendThread(127.0.0.1:37967)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x100dfceaa6f0004.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x100dfceaa6f0004, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x100dfceaa6f0004, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 804569 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 804570 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 804591 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1bdcfc10[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 804591 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@1bdcfc10[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 804609 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 804665 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@42e434de[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 804665 WARN  (jetty-launcher-6737-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@42e434de[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 804666 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37967/solr
   [junit4]   2> 804679 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 804746 INFO  (zkConnectionManagerCallback-6754-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 804746 INFO  (jetty-launcher-6737-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 804864 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 804884 INFO  (zkConnectionManagerCallback-6756-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 804885 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 804973 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41191_solr
   [junit4]   2> 804973 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.Overseer Overseer 
(id=72303672753586182-127.0.0.1:41191_solr-n_0000000000) starting
   [junit4]   2> 804989 INFO  
(OverseerStateUpdate-72303672753586182-127.0.0.1:41191_solr-n_0000000000) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:41191_solr
   [junit4]   2> 805013 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41191_solr
   [junit4]   2> 805015 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 805015 WARN  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 805036 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 805079 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 805121 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41191.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805128 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41191.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805128 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41191.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805130 INFO  (jetty-launcher-6737-thread-1) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node1
   [junit4]   2> 805189 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 805190 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 805191 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@66ca17c9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 805191 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@66ca17c9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 805193 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 805194 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7670870c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 805194 WARN  (jetty-launcher-6737-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7670870c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 805195 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37967/solr
   [junit4]   2> 805197 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 805201 INFO  (zkConnectionManagerCallback-6775-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 805201 INFO  (jetty-launcher-6737-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 805309 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 805325 INFO  (zkConnectionManagerCallback-6777-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 805325 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 805334 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 805345 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:38135_solr as DOWN
   [junit4]   2> 805351 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 805351 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38135_solr
   [junit4]   2> 805353 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 805355 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 805355 WARN  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 805365 INFO  (zkCallback-6776-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 805372 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 805412 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38135.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805421 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38135.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805421 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38135.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 805422 INFO  (jetty-launcher-6737-thread-2) 
[n:127.0.0.1:38135_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node2
   [junit4]   2> 805438 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 805439 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 805453 INFO  (zkConnectionManagerCallback-6790-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 805453 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 805454 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 805454 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37967/solr ready
   [junit4]   2> 805456 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [     ] 
o.a.s.c.TestTlogReplica Using legacyCloud?: false
   [junit4]   2> 805502 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_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> 805503 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_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> 805531 INFO  
(TEST-TestTlogReplica.testAddRemoveTlogReplica-seed#[B099051AE6FE71E7]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testAddRemoveTlogReplica
   [junit4]   2> 805532 INFO  (qtp666737593-11054) [n:127.0.0.1:41191_solr     
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_add_remove_tlog_replica&nrtReplicas=0&action=CREATE&numShards=2&tlogReplicas=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 805535 INFO  
(OverseerThreadFactory-6763-thread-1-processing-n:127.0.0.1:41191_solr) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
tlog_replica_test_add_remove_tlog_replica
   [junit4]   2> 805641 INFO  
(OverseerStateUpdate-72303672753586182-127.0.0.1:41191_solr-n_0000000000) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_add_remove_tlog_replica",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:38135/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38135_solr",
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 805643 INFO  
(OverseerStateUpdate-72303672753586182-127.0.0.1:41191_solr-n_0000000000) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_add_remove_tlog_replica",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 805880 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2&action=CREATE&numShards=2&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 805880 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1&action=CREATE&numShards=2&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 805881 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 805898 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 805898 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 806429 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 806429 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 806432 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 806432 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 806432 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2' using 
configuration from configset conf, trusted=true
   [junit4]   2> 806432 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1' using 
configuration from configset conf, trusted=true
   [junit4]   2> 806432 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41191.solr.core.tlog_replica_test_add_remove_tlog_replica.shard2.replica_t2'
 (registry 
'solr.core.tlog_replica_test_add_remove_tlog_replica.shard2.replica_t2') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 806432 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38135.solr.core.tlog_replica_test_add_remove_tlog_replica.shard1.replica_t1'
 (registry 
'solr.core.tlog_replica_test_add_remove_tlog_replica.shard1.replica_t1') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 806433 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SolrCore [[tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2] 
] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node1/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node1/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2/data/]
   [junit4]   2> 806433 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SolrCore [[tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1] 
] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node2/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node2/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1/data/]
   [junit4]   2> 806485 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 806485 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 806486 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 806486 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 806487 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 806487 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 806488 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 806488 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 806488 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 806489 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 806489 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 806489 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1680561938083348480
   [junit4]   2> 806491 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 806491 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 806491 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 806491 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1680561938085445632
   [junit4]   2> 806493 INFO  
(searcherExecutor-6793-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node4 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SolrCore [tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 806494 INFO  
(searcherExecutor-6794-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node3 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SolrCore [tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 806495 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard2 to 
Terms{values={core_node4=0}, version=0}
   [junit4]   2> 806495 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard2
   [junit4]   2> 806497 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard1 to 
Terms{values={core_node3=0}, version=0}
   [junit4]   2> 806497 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard1
   [junit4]   2> 806499 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 806499 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 806499 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:41191/solr/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2/
   [junit4]   2> 806499 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 806500 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:41191/solr/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2/
 has no replicas
   [junit4]   2> 806500 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ZkController 
tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 stopping background 
replication from leader
   [junit4]   2> 806500 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard2/leader 
after winning as 
/collections/tlog_replica_test_add_remove_tlog_replica/leader_elect/shard2/election/72303672753586182-core_node4-n_0000000000
   [junit4]   2> 806500 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 806500 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 806500 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:38135/solr/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1/
   [junit4]   2> 806501 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 806501 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:38135/solr/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1/
 has no replicas
   [junit4]   2> 806501 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ZkController 
tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 stopping background 
replication from leader
   [junit4]   2> 806501 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard1/leader 
after winning as 
/collections/tlog_replica_test_add_remove_tlog_replica/leader_elect/shard1/election/72303672753586184-core_node3-n_0000000000
   [junit4]   2> 806501 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:41191/solr/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2/
 shard2
   [junit4]   2> 806504 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:38135/solr/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1/
 shard1
   [junit4]   2> 806606 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806606 INFO  (zkCallback-6755-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806606 INFO  (zkCallback-6776-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806607 INFO  (zkCallback-6776-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806607 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 806609 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 806611 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr     
] 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_add_remove_tlog_replica_shard2_replica_t2&action=CREATE&numShards=2&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard2&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=730
   [junit4]   2> 806612 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr     
] 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_add_remove_tlog_replica_shard1_replica_t1&action=CREATE&numShards=2&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=732
   [junit4]   2> 806615 INFO  (qtp666737593-11054) [n:127.0.0.1:41191_solr     
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
45 seconds. Check all shard replicas
   [junit4]   2> 806713 INFO  (zkCallback-6755-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806713 INFO  (zkCallback-6776-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806713 INFO  (zkCallback-6755-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806713 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806713 INFO  (zkCallback-6776-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806713 INFO  (zkCallback-6776-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806714 INFO  (qtp666737593-11054) [n:127.0.0.1:41191_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_add_remove_tlog_replica&nrtReplicas=0&action=CREATE&numShards=2&tlogReplicas=1&wt=javabin&version=2}
 status=0 QTime=1181
   [junit4]   2> 806714 INFO  
(TEST-TestTlogReplica.testAddRemoveTlogReplica-seed#[B099051AE6FE71E7]) [     ] 
o.a.s.c.SolrCloudTestCase waitForState 
(tlog_replica_test_add_remove_tlog_replica): Expected collection to be created 
with 2 shards and  1 replicas
   [junit4]   2> 806715 INFO  
(TEST-TestTlogReplica.testAddRemoveTlogReplica-seed#[B099051AE6FE71E7]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
   [junit4]   2> 806715 INFO  (watches-6787-thread-1) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
   [junit4]   2> 806715 INFO  
(TEST-TestTlogReplica.testAddRemoveTlogReplica-seed#[B099051AE6FE71E7]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
   [junit4]   2> 806715 INFO  
(TEST-TestTlogReplica.testAddRemoveTlogReplica-seed#[B099051AE6FE71E7]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica count: 2
   [junit4]   2> 806763 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr     
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with 
params 
action=ADDREPLICA&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&type=TLOG
 and sendToOCPQueue=true
   [junit4]   2> 806765 INFO  
(OverseerCollectionConfigSetProcessor-72303672753586182-127.0.0.1:41191_solr-n_0000000000)
 [n:127.0.0.1:41191_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 806765 INFO  
(OverseerThreadFactory-6763-thread-2-processing-n:127.0.0.1:41191_solr) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1   
] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:41191_solr for creating 
new replica of shard shard1 for collection 
tlog_replica_test_add_remove_tlog_replica
   [junit4]   2> 806768 INFO  
(OverseerThreadFactory-6763-thread-2-processing-n:127.0.0.1:41191_solr) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1   
] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
   [junit4]   2> 806770 INFO  
(OverseerStateUpdate-72303672753586182-127.0.0.1:41191_solr-n_0000000000) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"addreplica",
   [junit4]   2>   "collection":"tlog_replica_test_add_remove_tlog_replica",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 806873 INFO  (zkCallback-6755-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806873 INFO  (zkCallback-6755-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806873 INFO  (zkCallback-6776-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806873 INFO  (zkCallback-6776-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806873 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806873 INFO  (zkCallback-6776-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 806972 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5&action=CREATE&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 806981 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 806988 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 806990 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 806990 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5' using 
configuration from configset conf, trusted=true
   [junit4]   2> 806991 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41191.solr.core.tlog_replica_test_add_remove_tlog_replica.shard1.replica_t5'
 (registry 
'solr.core.tlog_replica_test_add_remove_tlog_replica.shard1.replica_t5') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 806991 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.SolrCore [[tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5] 
] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node1/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node1/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5/data/]
   [junit4]   2> 807042 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 807043 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 807044 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 807044 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 807046 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 807046 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 807046 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 807047 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1680561938668453888
   [junit4]   2> 807048 INFO  
(searcherExecutor-6804-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.SolrCore [tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 807050 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard1 to 
Terms{values={core_node6=0, core_node3=0}, version=1}
   [junit4]   2> 807050 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard1
   [junit4]   2> 807052 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.ZkController Core needs to 
recover:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5
   [junit4]   2> 807052 INFO  
(updateExecutor-6750-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 807058 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 807058 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.RecoveryStrategy startupVersions is empty
   [junit4]   2> 807058 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.ZkController 
tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 stopping background 
replication from leader
   [junit4]   2> 807058 INFO  (qtp666737593-11058) [n:127.0.0.1:41191_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&name=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5&action=CREATE&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=87
   [junit4]   2> 807060 INFO  (qtp1115848390-11053) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica    ] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/collections 
params={action=ADDREPLICA&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard1&type=TLOG}
 status=0 QTime=297
   [junit4]   2> 807061 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.S.Request [tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1] 
 webapp=/solr path=/admin/ping params={wt=javabin&version=2} hits=0 status=0 
QTime=0
   [junit4]   2> 807061 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node3 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.c.S.Request [tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1] 
 webapp=/solr path=/admin/ping params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 807061 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.RecoveryStrategy Begin buffering updates. 
core=[tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5]
   [junit4]   2> 807061 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 807061 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.RecoveryStrategy Publishing state of core 
[tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5] as recovering, 
leader is 
[https://127.0.0.1:38135/solr/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1/]
 and I am 
[https://127.0.0.1:41191/solr/tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5/]
   [junit4]   2> 807063 INFO  
(recoveryExecutor-6752-thread-1-processing-n:127.0.0.1:41191_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 
c:tlog_replica_test_add_remove_tlog_replica s:shard1 r:core_node6) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard1 
r:core_node6 x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5 ] 
o.a.s.c.RecoveryStrategy Sending prep recovery command to 
[https://127.0.0.1:38135/solr]; [WaitForState: 
action=PREPRECOVERY&core=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1&nodeName=127.0.0.1:41191_solr&coreNodeName=core_node6&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
   [junit4]   2> 807069 INFO  (qtp1115848390-11049) [n:127.0.0.1:38135_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1 ] 
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node6, state: 
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
   [junit4]   2> 807069 INFO  (qtp1115848390-11049) [n:127.0.0.1:38135_solr     
] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): 
collection=tlog_replica_test_add_remove_tlog_replica, shard=shard1, 
thisCore=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:41191_solr, 
coreNodeName=core_node6, onlyIfActiveCheckResult=false, nodeProps: core_node6:{
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "state":"down",
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "type":"TLOG"}
   [junit4]   2> 807069 INFO  (qtp1115848390-11049) [n:127.0.0.1:38135_solr     
] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): 
collection=tlog_replica_test_add_remove_tlog_replica, shard=shard1, 
thisCore=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:41191_solr, 
coreNodeName=core_node6, onlyIfActiveCheckResult=false, nodeProps: core_node6:{
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "state":"down",
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "type":"TLOG"}
   [junit4]   2> 807069 INFO  (qtp1115848390-11049) [n:127.0.0.1:38135_solr     
] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): 
collection=tlog_replica_test_add_remove_tlog_replica, shard=shard1, 
thisCore=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:41191_solr, 
coreNodeName=core_node6, onlyIfActiveCheckResult=false, nodeProps: core_node6:{
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "state":"down",
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "type":"TLOG"}
   [junit4]   2> 807075 INFO  
(OverseerCollectionConfigSetProcessor-72303672753586182-127.0.0.1:41191_solr-n_0000000000)
 [n:127.0.0.1:41191_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 807075 INFO  
(OverseerThreadFactory-6763-thread-3-processing-n:127.0.0.1:41191_solr) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2   
] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:38135_solr for creating 
new replica of shard shard2 for collection 
tlog_replica_test_add_remove_tlog_replica
   [junit4]   2> 807077 INFO  
(OverseerThreadFactory-6763-thread-3-processing-n:127.0.0.1:41191_solr) 
[n:127.0.0.1:41191_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2   
] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
   [junit4]   2> 807078 INFO  
(OverseerStateUpdate-72303672753586182-127.0.0.1:41191_solr-n_0000000000) 
[n:127.0.0.1:41191_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"addreplica",
   [junit4]   2>   "collection":"tlog_replica_test_add_remove_tlog_replica",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:38135/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38135_solr",
   [junit4]   2>   "type":"TLOG"} 
   [junit4]   2> 807180 INFO  (zkCallback-6776-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807180 INFO  (zkCallback-6755-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807180 INFO  (zkCallback-6776-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807180 INFO  (zkCallback-6755-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807180 INFO  (zkCallback-6776-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807180 INFO  (zkCallback-6755-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_add_remove_tlog_replica/state.json] for 
collection [tlog_replica_test_add_remove_tlog_replica] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 807181 INFO  (watches-6778-thread-1) [n:127.0.0.1:38135_solr   
  ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): 
collection=tlog_replica_test_add_remove_tlog_replica, shard=shard1, 
thisCore=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=recovering, localState=active, nodeName=127.0.0.1:41191_solr, 
coreNodeName=core_node6, onlyIfActiveCheckResult=false, nodeProps: core_node6:{
   [junit4]   2>   
"core":"tlog_replica_test_add_remove_tlog_replica_shard1_replica_t5",
   [junit4]   2>   "base_url":"https://127.0.0.1:41191/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41191_solr",
   [junit4]   2>   "state":"recovering",
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 807181 INFO  (qtp1115848390-11049) [n:127.0.0.1:38135_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={nodeName=127.0.0.1:41191_solr&onlyIfLeaderActive=true&core=tlog_replica_test_add_remove_tlog_replica_shard1_replica_t1&coreNodeName=core_node6&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
 status=0 QTime=112
   [junit4]   2> 807280 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr    
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&name=tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7&action=CREATE&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard2&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 807290 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
   [junit4]   2> 807297 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 807299 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 807299 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7' using 
configuration from configset conf, trusted=true
   [junit4]   2> 807299 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38135.solr.core.tlog_replica_test_add_remove_tlog_replica.shard2.replica_t7'
 (registry 
'solr.core.tlog_replica_test_add_remove_tlog_replica.shard2.replica_t7') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@e815459
   [junit4]   2> 807300 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.SolrCore [[tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7] 
] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node2/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001/tempDir-001/node2/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7/data/]
   [junit4]   2> 807346 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 807346 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 807347 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 807347 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 807349 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 807349 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 807350 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 807350 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1680561938986172416
   [junit4]   2> 807352 INFO  
(searcherExecutor-6811-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.SolrCore [tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 807353 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard2 to 
Terms{values={core_node4=0, core_node8=0}, version=1}
   [junit4]   2> 807354 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/tlog_replica_test_add_remove_tlog_replica/leaders/shard2
   [junit4]   2> 807355 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.ZkController Core needs to 
recover:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7
   [junit4]   2> 807356 INFO  
(updateExecutor-6771-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 807357 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 807357 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.RecoveryStrategy startupVersions is empty
   [junit4]   2> 807357 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.ZkController 
tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 stopping background 
replication from leader
   [junit4]   2> 807357 INFO  (qtp1115848390-11051) [n:127.0.0.1:38135_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&name=tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7&action=CREATE&collection=tlog_replica_test_add_remove_tlog_replica&shard=shard2&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=77
   [junit4]   2> 807360 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.S.Request [tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2] 
 webapp=/solr path=/admin/ping params={wt=javabin&version=2} hits=0 status=0 
QTime=0
   [junit4]   2> 807360 INFO  (qtp666737593-11060) [n:127.0.0.1:41191_solr 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node4 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2 ] 
o.a.s.c.S.Request [tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2] 
 webapp=/solr path=/admin/ping params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 807360 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.RecoveryStrategy Begin buffering updates. 
core=[tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7]
   [junit4]   2> 807360 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 807360 INFO  
(recoveryExecutor-6773-thread-1-processing-n:127.0.0.1:38135_solr 
x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 
c:tlog_replica_test_add_remove_tlog_replica s:shard2 r:core_node8) 
[n:127.0.0.1:38135_solr c:tlog_replica_test_add_remove_tlog_replica s:shard2 
r:core_node8 x:tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7 ] 
o.a.s.c.RecoveryStrategy Publishing state of core 
[tlog_replica_test_add_remove_tlog_replica_shard2_replica_t7] as recovering, 
leader is 
[https://127.0.0.1:41191/solr/tlog_replica_test_add_remove_tlog_replica_shard2_replica_t2/]
 and I am [https://127.0.0.1:38135/solr/tlog_replica

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

) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 890112 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [n:127.0.0.1:38135_solr  
   ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 890315 WARN  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        33      
/solr/collections/tlog_replica_test_create_delete/terms/shard1
   [junit4]   2>        32      /solr/configs/conf
   [junit4]   2>        30      
/solr/collections/tlog_replica_test_create_delete/terms/shard2
   [junit4]   2>        18      
/solr/collections/tlog_replica_test_remove_leader/terms/shard1
   [junit4]   2>        17      
/solr/collections/tlog_replica_test_recovery/terms/shard1
   [junit4]   2>        17      
/solr/collections/tlog_replica_test_kill_leader/terms/shard1
   [junit4]   2>        16      
/solr/collections/tlog_replica_test_basic_leader_election/terms/shard1
   [junit4]   2>        13      
/solr/collections/tlog_replica_test_add_docs/terms/shard1
   [junit4]   2>        10      
/solr/collections/tlog_replica_test_delete_by_id/terms/shard1
   [junit4]   2>        9       /solr/aliases.json
   [junit4]   2>        9       
/solr/collections/tlog_replica_test_rebalance_leaders/terms/shard1
   [junit4]   2>        9       
/solr/collections/tlog_replica_test_only_leader_indexes/terms/shard1
   [junit4]   2>        8       
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/terms/shard1
   [junit4]   2>        8       
/solr/collections/tlog_replica_test_create_delete/state.json
   [junit4]   2>        8       /solr/packages.json
   [junit4]   2>        8       /solr/security.json
   [junit4]   2>        8       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard2
   [junit4]   2>        7       
/solr/collections/tlog_replica_test_add_docs/state.json
   [junit4]   2>        7       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard1
   [junit4]   2>        6       
/solr/collections/tlog_replica_test_real_time_get/state.json
   [junit4]   2>        5       
/solr/collections/tlog_replica_test_kill_leader/state.json
   [junit4]   2>        5       
/solr/collections/tlog_replica_test_remove_leader/state.json
   [junit4]   2>        5       
/solr/collections/tlog_replica_test_recovery/collectionprops.json
   [junit4]   2>        5       
/solr/collections/tlog_replica_test_delete_by_id/state.json
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_rebalance_leaders/state.json
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_real_time_get/terms/shard1
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_only_leader_indexes/state.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_basic_leader_election/collectionprops.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_kill_leader/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_delete_by_id/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_rebalance_leaders/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_add_docs/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_remove_leader/collectionprops.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_only_leader_indexes/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        88      
/solr/collections/tlog_replica_test_recovery/state.json
   [junit4]   2>        69      
/solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
   [junit4]   2>        61      
/solr/collections/tlog_replica_test_kill_leader/state.json
   [junit4]   2>        59      
/solr/collections/tlog_replica_test_remove_leader/state.json
   [junit4]   2>        58      
/solr/collections/tlog_replica_test_create_delete/state.json
   [junit4]   2>        56      
/solr/collections/tlog_replica_test_basic_leader_election/state.json
   [junit4]   2>        55      
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
   [junit4]   2>        28      
/solr/collections/tlog_replica_test_rebalance_leaders/state.json
   [junit4]   2>        28      
/solr/collections/tlog_replica_test_only_leader_indexes/state.json
   [junit4]   2>        26      
/solr/collections/tlog_replica_test_add_docs/state.json
   [junit4]   2>        18      
/solr/collections/tlog_replica_test_delete_by_id/state.json
   [junit4]   2>        16      
/solr/collections/tlog_replica_test_real_time_get/state.json
   [junit4]   2>        12      /solr/clusterprops.json
   [junit4]   2>        9       /solr/clusterstate.json
   [junit4]   2>        5       
/solr/overseer_elect/election/72303672753586184-127.0.0.1:38135_solr-n_0000000001
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/72303672753586184-core_node4-n_0000000000
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72303672753586184-core_node3-n_0000000000
   [junit4]   2>        3       /solr/autoscaling.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/72303672753586184-core_node11-n_0000000000
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72303672753586184-core_node3-n_0000000001
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72303672753586182-core_node5-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        371     /solr/overseer/queue
   [junit4]   2>        122     /solr/overseer/collection-queue-work
   [junit4]   2>        87      /solr/collections
   [junit4]   2>        43      /solr/live_nodes
   [junit4]   2>        3       /solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2>        3       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 890324 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [n:127.0.0.1:38135_solr  
   ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:37967
   [junit4]   2> 890324 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [n:127.0.0.1:38135_solr  
   ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37967
   [junit4]   2> 890324 INFO  
(SUITE-TestTlogReplica-seed#[B099051AE6FE71E7]-worker) [n:127.0.0.1:38135_solr  
   ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 37967
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_B099051AE6FE71E7-001
   [junit4]   2> Oct 14, 2020 8:54:01 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {foo=FST50, 
_root_=FST50, title_s=PostingsFormat(name=LuceneVarGapFixedInterval), 
foo_s=FST50, id=Lucene84}, 
docValues:{_version_=DocValuesFormat(name=Asserting), 
id=DocValuesFormat(name=Lucene80), 
inplace_updatable_int=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=381, 
maxMBSortInHeap=6.816415384801504, 
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=tr, 
timezone=Portugal
   [junit4]   2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 
1.8.0_252 (64-bit)/cpus=4,threads=1,free=324034576,total=518520832
   [junit4]   2> NOTE: All tests run in this JVM: [SuggesterFSTTest, 
TestStressCloudBlindAtomicUpdates, ConcurrentDeleteAndCreateCollectionTest, 
TestExternalRoleRuleBasedAuthorizationPlugin, TestHttpServletCarrier, 
RoutingToNodesWithPropertiesTest, TestEmbeddedSolrServerConstructors, 
TestImpersonationWithHadoopAuth, ZkControllerTest, ZkSolrClientTest, 
TestDocBasedVersionConstraints, UUIDFieldTest, SimplePostToolTest, 
HdfsUnloadDistributedZkTest, FacetPivotSmallTest, SuggestComponentTest, 
TestSimpleTextCodec, VersionInfoTest, DeleteReplicaTest, FileUtilsTest, 
TestSolrQueryResponse, TestSearchPerf, ConvertedLegacyTest, TestSimScenario, 
TestRandomCollapseQParserPlugin, TestDistributedGrouping, 
DataDrivenBlockJoinTest, AuditLoggerPluginTest, TestLegacyFieldReuse, 
ActionThrottleTest, JWTAuthPluginIntegrationTest, CursorMarkTest, 
TestInPlaceUpdatesRequiredField, RAMDirectoryFactoryTest, 
UpdateRequestProcessorFactoryTest, IndexSizeTriggerSizeEstimationTest, 
LeaderTragicEventTest, TestFreeTextSuggestions, TestSortableTextField, 
TestFoldingMultitermQuery, TestCoreBackup, DistributedFacetPivotLargeTest, 
TestSolrIndexConfig, PeerSyncTest, SolrRrdBackendFactoryTest, 
TestSystemCollAutoCreate, TestWriterPerf, TestSubQueryTransformer, 
CleanupOldIndexTest, DistributedQueryElevationComponentTest, 
PreAnalyzedFieldTest, NodeAddedTriggerIntegrationTest, CSVRequestHandlerTest, 
TestJmxIntegration, DistributedFacetSimpleRefinementLongTailTest, 
SynonymTokenizerTest, TestCloudNestedDocsSort, ExitableDirectoryReaderTest, 
TestJsonFacets, TestExactSharedStatsCache, TestSimDistributedQueue, 
SystemCollectionCompatTest, TestTlogReplica]
   [junit4] Completed [278/919 (1!)] on J2 in 86.93s, 14 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 54447 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:634:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:507:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:495:
 Source checkout is modified!!! Offending files:
* lucene/licenses/junit-4.13.1.jar.sha1
* solr/licenses/junit-4.13.1.jar.sha1

Total time: 71 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to