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

1 tests failed.
FAILED:  
org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap

Error Message:
Could not find a healthy node to handle the request.

Stack Trace:
org.apache.solr.common.SolrException: Could not find a healthy node to handle 
the request.
        at 
__randomizedtesting.SeedInfo.seed([40933F3B4A58C69B:9744104CFE075EDC]:0)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1165)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
        at 
org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap(CdcrBootstrapTest.java:124)
        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 15583 lines...]
   [junit4] Suite: org.apache.solr.cloud.cdcr.CdcrBootstrapTest
   [junit4]   2> 1937062 INFO  
(SUITE-CdcrBootstrapTest-seed#[40933F3B4A58C69B]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1937062 INFO  
(SUITE-CdcrBootstrapTest-seed#[40933F3B4A58C69B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1937063 INFO  
(SUITE-CdcrBootstrapTest-seed#[40933F3B4A58C69B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/data-dir-229-001
   [junit4]   2> 1937063 INFO  
(SUITE-CdcrBootstrapTest-seed#[40933F3B4A58C69B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1937063 INFO  
(SUITE-CdcrBootstrapTest-seed#[40933F3B4A58C69B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1937066 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.SolrTestCaseJ4 ###Starting testBootstrapWithSourceCluster
   [junit4]   2> 1937066 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-target-001
   [junit4]   2> 1937067 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1937067 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1937067 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1937068 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1937167 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer start zk server on port: 46585
   [junit4]   2> 1937167 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46585
   [junit4]   2> 1937167 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46585
   [junit4]   2> 1937167 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46585
   [junit4]   2> 1937168 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1937174 INFO  (zkConnectionManagerCallback-20036-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1937174 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1937180 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1937183 INFO  (zkConnectionManagerCallback-20038-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1937183 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1937185 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1937186 INFO  (zkConnectionManagerCallback-20040-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1937186 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1937187 WARN  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]-SendThread(127.0.0.1:46585))
 [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for 
session 0x101598506950002.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101598506950002, 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 0x101598506950002, 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> 1937288 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1937288 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1937288 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 
98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1937301 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1937301 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1937301 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4f722a88{/solr,null,AVAILABLE}
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3762023d{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:46241}
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.s.Server Started @1937331ms
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:46585/solr, hostPort=46241}
   [junit4]   2> 1937304 ERROR (jetty-launcher-20041-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.10.0
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 1937304 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-07-05T10:29:58.312Z
   [junit4]   2> 1937305 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1937305 INFO  (zkConnectionManagerCallback-20043-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1937305 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1937306 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1937309 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1937309 WARN  
(jetty-launcher-20041-thread-1-SendThread(127.0.0.1:46585)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x101598506950003.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101598506950003, 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 0x101598506950003, 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> 1938723 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1938723 WARN  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@507c4741[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1938723 WARN  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@507c4741[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1938725 WARN  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7794e2d9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1938725 WARN  (jetty-launcher-20041-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7794e2d9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1938726 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46585/solr
   [junit4]   2> 1938727 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1938728 INFO  (zkConnectionManagerCallback-20054-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1938728 INFO  (jetty-launcher-20041-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1938829 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1938830 INFO  (zkConnectionManagerCallback-20056-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1938830 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1938878 WARN  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1938881 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:46241_solr
   [junit4]   2> 1938882 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.Overseer Overseer 
(id=72437496890589189-127.0.0.1:46241_solr-n_0000000000) starting
   [junit4]   2> 1938885 INFO  
(OverseerStateUpdate-72437496890589189-127.0.0.1:46241_solr-n_0000000000) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:46241_solr
   [junit4]   2> 1938886 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46241_solr
   [junit4]   2> 1938886 INFO  
(OverseerStateUpdate-72437496890589189-127.0.0.1:46241_solr-n_0000000000) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1938888 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1938888 WARN  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_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> 1938902 INFO  (jetty-launcher-20041-thread-1) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-target-001/node1
   [junit4]   2> 1938913 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 1938914 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1938914 INFO  (zkConnectionManagerCallback-20071-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1938914 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1938915 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1938916 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:46585/solr ready
   [junit4]   1> Target zkHost = 127.0.0.1:46585/solr
   [junit4]   2> 1938916 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-source-001
   [junit4]   2> 1938917 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1938920 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1938920 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1938920 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1939020 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer start zk server on port: 35871
   [junit4]   2> 1939020 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:35871
   [junit4]   2> 1939020 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:35871
   [junit4]   2> 1939020 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 35871
   [junit4]   2> 1939021 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939023 INFO  (zkConnectionManagerCallback-20073-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939023 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1939031 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939035 INFO  (zkConnectionManagerCallback-20075-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939035 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1939036 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939039 INFO  (zkConnectionManagerCallback-20077-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939039 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 
98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1939142 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@26b13775{/solr,null,AVAILABLE}
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6c5b26c7{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:36289}
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.s.Server Started @1939169ms
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:35871/solr, hostPort=36289}
   [junit4]   2> 1939143 ERROR (jetty-launcher-20078-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.10.0
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 1939143 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-07-05T10:30:00.151Z
   [junit4]   2> 1939147 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939148 INFO  (zkConnectionManagerCallback-20080-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939148 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1939149 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1939171 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 1939794 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1939795 WARN  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@a560f5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1939795 WARN  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@a560f5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1939797 WARN  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@386bf654[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1939797 WARN  (jetty-launcher-20078-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@386bf654[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1939798 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35871/solr
   [junit4]   2> 1939798 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939799 INFO  (zkConnectionManagerCallback-20091-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939799 INFO  (jetty-launcher-20078-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1939905 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1939905 INFO  (zkConnectionManagerCallback-20093-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1939905 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1939961 WARN  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.ZkController Contents of zookeeper 
/security.json are world-readable; consider setting up ACLs as described in 
https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 1939964 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:36289_solr
   [junit4]   2> 1939965 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.Overseer Overseer 
(id=72437497012420613-127.0.0.1:36289_solr-n_0000000000) starting
   [junit4]   2> 1939969 INFO  
(OverseerStateUpdate-72437497012420613-127.0.0.1:36289_solr-n_0000000000) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:36289_solr
   [junit4]   2> 1939969 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36289_solr
   [junit4]   2> 1939970 INFO  
(OverseerStateUpdate-72437497012420613-127.0.0.1:36289_solr-n_0000000000) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1939972 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1939972 WARN  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_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> 1939986 INFO  (jetty-launcher-20078-thread-1) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-source-001/node1
   [junit4]   2> 1939996 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 1939997 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1939999 INFO  (zkConnectionManagerCallback-20108-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1940000 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1940001 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1940001 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:35871/solr ready
   [junit4]   2> 1940002 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1940003 INFO  (zkConnectionManagerCallback-20110-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1940004 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1940111 INFO  
(OverseerThreadFactory-20100-thread-1-processing-n:127.0.0.1:36289_solr) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
cdcr-source
   [junit4]   2> 1940217 INFO  
(OverseerStateUpdate-72437497012420613-127.0.0.1:36289_solr-n_0000000000) 
[n:127.0.0.1:36289_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"cdcr-source_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:36289_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:36289/solr";,
   [junit4]   2>   "collection":"cdcr-source",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1940420 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr    
x:cdcr-source_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&collection=cdcr-source&version=2&replicaType=NRT&coreNodeName=core_node2&name=cdcr-source_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin
   [junit4]   2> 1940421 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr    
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient core cache for max 2147483647 cores with initial capacity 
of 1024
   [junit4]   2> 1940441 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 1940441 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema.xml instead
   [junit4]   2> 1940443 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1940443 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1940445 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at 
/configs/cdcr-source/managed-schema
   [junit4]   2> 1940448 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in 
ZooKeeper, renamed the non-managed schema /configs/cdcr-source/schema.xml to 
/configs/cdcr-source/schema.xml.bak
   [junit4]   2> 1940449 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore 'cdcr-source_shard1_replica_n1' using 
configuration from configset cdcr-source, trusted=true
   [junit4]   2> 1940449 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.SolrCore [[cdcr-source_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-source-001/node1/cdcr-source_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-source-001/node1/cdcr-source_shard1_replica_n1/data/]
   [junit4]   2> 1940523 WARN  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.D.s.CdcrRequestHandler Solr loaded a deprecated plugin/analysis class 
[solr.CdcrRequestHandler]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 1940523 WARN  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrRequestHandler CDCR (in its current form) is deprecated as of 8.6 
and shall be removed in 9.0. See SOLR-14022 for details.
   [junit4]   2> 1940524 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 1940524 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1940525 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1940525 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1940527 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cdcr-source
   [junit4]   2> 1940528 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cdcr-source
   [junit4]   2> 1940528 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/cdcr-source/managed-schema
   [junit4]   2> 1940528 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1940528 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1940532 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrBufferStateManager Created znode 
/collections/cdcr-source/cdcr/state/buffer
   [junit4]   2> 1940535 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrProcessStateManager Created znode 
/collections/cdcr-source/cdcr/state/process
   [junit4]   2> 1940553 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1704440366692827136
   [junit4]   2> 1940555 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1940559 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/cdcr-source/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1940559 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/cdcr-source/leaders/shard1
   [junit4]   2> 1940562 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1940562 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1940562 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:36289/solr/cdcr-source_shard1_replica_n1/
   [junit4]   2> 1940563 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1940563 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:36289/solr/cdcr-source_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 1940563 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/cdcr-source/leaders/shard1/leader after winning as 
/collections/cdcr-source/leader_elect/shard1/election/72437497012420613-core_node2-n_0000000000
   [junit4]   2> 1940564 INFO  (zkCallback-20092-thread-1) [     ] 
o.a.s.h.CdcrLeaderStateManager Received new leader state @ cdcr-source:shard1
   [junit4]   2> 1940567 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:36289/solr/cdcr-source_shard1_replica_n1/ shard1
   [junit4]   2> 1940668 INFO  (zkCallback-20092-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1940669 INFO  (zkCallback-20092-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1940670 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1940672 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&collection=cdcr-source&version=2&replicaType=NRT&coreNodeName=core_node2&name=cdcr-source_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin}
 status=0 QTime=252
   [junit4]   2> 1940674 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_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> 1940772 INFO  (zkCallback-20092-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1940772 INFO  (zkCallback-20092-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1940772 INFO  (zkCallback-20092-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1940773 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=cdcr-source&name=cdcr-source&nrtReplicas=1&action=CREATE&numShards=1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2}
 status=0 QTime=665
   [junit4]   2> 1940773 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: cdcr-source
   [junit4]   2> 1940784 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/cdcr-source/terms/shard1 to Terms{values={core_node2=1}, version=1}
   [junit4]   2> 1940784 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=8
   [junit4]   2> 1941095 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1941095 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=310
   [junit4]   2> 1941101 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=4
   [junit4]   2> 1941390 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1941390 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=289
   [junit4]   2> 1941395 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1941684 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1941684 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=288
   [junit4]   2> 1941689 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1941982 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1941983 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=293
   [junit4]   2> 1941987 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1942113 INFO  
(OverseerCollectionConfigSetProcessor-72437497012420613-127.0.0.1:36289_solr-n_0000000000)
 [n:127.0.0.1:36289_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> 1942269 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1942269 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=281
   [junit4]   2> 1942274 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1942567 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1942567 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=291
   [junit4]   2> 1942571 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1942866 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1942866 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=294
   [junit4]   2> 1942871 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1943161 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1943161 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=290
   [junit4]   2> 1943167 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=4
   [junit4]   2> 1943471 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1943471 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=304
   [junit4]   2> 1943476 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 1943789 INFO  
(searcherExecutor-20112-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1943789 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-source:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=312
   [junit4]   2> 1943789 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.CdcrBootstrapTest Adding numDocs=1000
   [junit4]   2> 1943790 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=cdcr-source:4&wt=javabin&version=2} hits=1000 status=0 
QTime=0
   [junit4]   2> 1943791 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1943793 INFO  (zkConnectionManagerCallback-20120-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1943793 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1943796 WARN  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]-SendThread(127.0.0.1:46585))
 [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for 
session 0x101598506950007.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x101598506950007, 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 0x101598506950007, 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> 1943902 INFO  
(OverseerThreadFactory-20063-thread-1-processing-n:127.0.0.1:46241_solr) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
cdcr-target
   [junit4]   2> 1944008 INFO  
(OverseerStateUpdate-72437496890589189-127.0.0.1:46241_solr-n_0000000000) 
[n:127.0.0.1:46241_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"cdcr-target_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:46241_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:46241/solr";,
   [junit4]   2>   "collection":"cdcr-target",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1944212 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr    
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=cdcr-target&newCollection=true&name=cdcr-target_shard1_replica_n1&action=CREATE&numShards=1&collection=cdcr-target&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1944212 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr    
x:cdcr-target_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient core cache for max 2147483647 cores with initial capacity 
of 1024
   [junit4]   2> 1944222 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 1944222 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema.xml instead
   [junit4]   2> 1944223 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1944223 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1944225 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at 
/configs/cdcr-target/managed-schema
   [junit4]   2> 1944226 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in 
ZooKeeper, renamed the non-managed schema /configs/cdcr-target/schema.xml to 
/configs/cdcr-target/schema.xml.bak
   [junit4]   2> 1944227 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore 'cdcr-target_shard1_replica_n1' using 
configuration from configset cdcr-target, trusted=true
   [junit4]   2> 1944227 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.SolrCore [[cdcr-target_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-target-001/node1/cdcr-target_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001/cdcr-target-001/node1/cdcr-target_shard1_replica_n1/data/]
   [junit4]   2> 1944253 WARN  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.h.CdcrRequestHandler CDCR (in its current form) is deprecated as of 8.6 
and shall be removed in 9.0. See SOLR-14022 for details.
   [junit4]   2> 1944253 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.CdcrUpdateLog
   [junit4]   2> 1944253 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1944254 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1944254 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1944255 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cdcr-target
   [junit4]   2> 1944255 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cdcr-target
   [junit4]   2> 1944255 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/cdcr-target/managed-schema
   [junit4]   2> 1944256 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1944256 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1944257 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.h.CdcrBufferStateManager Created znode 
/collections/cdcr-target/cdcr/state/buffer
   [junit4]   2> 1944258 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.h.CdcrProcessStateManager Created znode 
/collections/cdcr-target/cdcr/state/process
   [junit4]   2> 1944259 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1704440370578849792
   [junit4]   2> 1944260 INFO  
(searcherExecutor-20122-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.c.SolrCore 
[cdcr-target_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1944264 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/cdcr-target/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1944264 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/cdcr-target/leaders/shard1
   [junit4]   2> 1944267 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1944267 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1944267 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:46241/solr/cdcr-target_shard1_replica_n1/
   [junit4]   2> 1944268 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1944268 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy http://127.0.0.1:46241/solr/cdcr-target_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 1944268 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/cdcr-target/leaders/shard1/leader after winning as 
/collections/cdcr-target/leader_elect/shard1/election/72437496890589189-core_node2-n_0000000000
   [junit4]   2> 1944271 INFO  (zkCallback-20055-thread-1) [     ] 
o.a.s.h.CdcrLeaderStateManager Received new leader state @ cdcr-target:shard1
   [junit4]   2> 1944274 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46241/solr/cdcr-target_shard1_replica_n1/ shard1
   [junit4]   2> 1944376 INFO  (zkCallback-20055-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944376 INFO  (zkCallback-20055-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944376 INFO  (zkCallback-20055-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944376 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1944378 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=cdcr-target&newCollection=true&name=cdcr-target_shard1_replica_n1&action=CREATE&numShards=1&collection=cdcr-target&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=166
   [junit4]   2> 1944380 INFO  (qtp967175033-33594) [n:127.0.0.1:46241_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> 1944478 INFO  (zkCallback-20055-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944478 INFO  (zkCallback-20055-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944478 INFO  (zkCallback-20055-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944478 INFO  (zkCallback-20055-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1944478 INFO  (qtp967175033-33594) [n:127.0.0.1:46241_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=cdcr-target&name=cdcr-target&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=581
   [junit4]   2> 1944479 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: cdcr-target
   [junit4]   2> 1944486 INFO  (zkCallback-20055-thread-3) [     ] 
o.a.s.h.CdcrProcessStateManager The CDCR process state has changed: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/cdcr/state/process @ cdcr-target:shard1
   [junit4]   2> 1944486 INFO  (qtp967175033-33597) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={qt=/cdcr&_stateVer_=cdcr-target:3&action=start&wt=javabin&version=2} 
status=0 QTime=2
   [junit4]   2> 1944486 INFO  (zkCallback-20055-thread-3) [     ] 
o.a.s.h.CdcrProcessStateManager Received new CDCR process state from watcher: 
STARTED @ cdcr-target:shard1
   [junit4]   2> 1944487 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1944488 INFO  (zkConnectionManagerCallback-20134-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1944488 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1944489 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1944490 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46585/solr ready
   [junit4]   2> 1944494 INFO  (qtp967175033-33594) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.h.CdcrRequestHandler Found maxVersionFromRecent 0 maxVersionFromIndex 0
   [junit4]   2> 1944494 INFO  (qtp967175033-33594) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={action=SHARDCHECKPOINT&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1944495 INFO  (qtp967175033-33595) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={_stateVer_=cdcr-target:3&action=COLLECTIONCHECKPOINT&wt=javabin&version=2}
 status=0 QTime=4
   [junit4]   2> 1944495 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrReplicatorManager Create new update log reader for target 
cdcr-target with checkpoint -1 @ cdcr-source:shard1
   [junit4]   2> 1944495 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrReplicatorManager Attempting to bootstrap target collection: 
cdcr-target, shard: shard1
   [junit4]   2> 1944497 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.h.CdcrReplicatorManager Submitting bootstrap task to executor
   [junit4]   2> 1944498 INFO  (zkCallback-20092-thread-4) [     ] 
o.a.s.h.CdcrProcessStateManager The CDCR process state has changed: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/cdcr/state/process @ cdcr-source:shard1
   [junit4]   2> 1944498 INFO  (zkCallback-20092-thread-4) [     ] 
o.a.s.h.CdcrProcessStateManager Received new CDCR process state from watcher: 
STARTED @ cdcr-source:shard1
   [junit4]   2> 1944498 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={qt=/cdcr&_stateVer_=cdcr-source:4&action=start&wt=javabin&version=2} 
status=0 QTime=12
   [junit4]   2> 1944499 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={qt=/cdcr&_stateVer_=cdcr-source:4&action=queues&wt=javabin&version=2} 
status=0 QTime=0
   [junit4]   2> 1944500 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithSourceCluster-seed#[40933F3B4A58C69B]) 
[     ] o.a.s.c.c.CdcrBootstrapTest Cdcr queue response: 
{responseHeader={status=0,QTime=0},queues={127.0.0.1:46585/solr={cdcr-target={queueSize=1010,lastTimestamp=}}},tlogTotalSize=60619,tlogTotalCount=10,updateLogSynchronizer=stopped}
   [junit4]   2> 1944500 INFO  (qtp967175033-33596) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/update 
params={_stateVer_=cdcr-target:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1944501 INFO  (qtp967175033-33594) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=cdcr-target:3&wt=javabin&version=2} hits=0 status=0 
QTime=0
   [junit4]   2> 1944501 INFO  
(cdcr-bootstrap-status-20130-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.h.CdcrReplicatorManager Attempting to 
bootstrap target collection: cdcr-target shard: shard1 leader: 
http://127.0.0.1:46241/solr/cdcr-target_shard1_replica_n1/
   [junit4]   2> 1944502 INFO  (qtp967175033-33597) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={qt=/cdcr&masterUrl=http://127.0.0.1:36289/solr/cdcr-source_shard1_replica_n1/&action=BOOTSTRAP&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1944504 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.u.UpdateLog Starting to buffer updates. 
FSUpdateLog{state=ACTIVE, tlog=null}
   [junit4]   2> 1944506 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr path=/update 
params={waitSearcher=true&openSearcher=false&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1944507 INFO  (qtp967175033-33593) [n:127.0.0.1:46241_solr 
c:cdcr-target s:shard1 r:core_node2 x:cdcr-target_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-target_shard1_replica_n1]  webapp=/solr path=/cdcr 
params={qt=/cdcr&action=BOOTSTRAP_STATUS&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1944507 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 1944507 INFO  
(cdcr-bootstrap-status-20130-thread-1-processing-n:127.0.0.1:36289_solr 
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2) 
[n:127.0.0.1:36289_solr c:cdcr-source s:shard1 r:core_node2 
x:cdcr-source_shard1_replica_n1 ] o.a.s.h.CdcrReplicatorManager CDCR bootstrap 
running for 1 seconds, sleeping for 2000 ms
   [junit4]   2> 1944507 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Leader's generation: 11
   [junit4]   2> 1944507 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Leader's version: 
1625481004484
   [junit4]   2> 1944507 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Follower's generation: 1
   [junit4]   2> 1944507 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Follower's version: 0
   [junit4]   2> 1944507 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Starting replication 
process
   [junit4]   2> 1944529 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=21
   [junit4]   2> 1944529 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Number of files in 
latest index in leader: 279
   [junit4]   2> 1944534 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.u.DefaultSolrCoreState New IndexWriter 
is ready to be used.
   [junit4]   2> 1944534 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher Starting download 
(fullCopy=false) to MockDirectoryWrapper(RAMDirectory@1e6c0293 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6a70e35a)
   [junit4]   2> 1944534 INFO  
(recoveryExecutor-20052-thread-1-processing-n:127.0.0.1:46241_solr 
x:cdcr-target_shard1_replica_n1 c:cdcr-target s:shard1 r:core_node2) 
[n:127.0.0.1:46241_solr c:cdcr-target s:shard1 r:core_node2 
x:cdcr-target_shard1_replica_n1 ] o.a.s.h.IndexFetcher tmpIndexDir_type  : 
class org.apache.lucene.store.MockDirectoryWrapper , RAMDirectory@1e6c0293 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6a70e35a
   [junit4]   2> 1944535 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Direct_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944535 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_TestBloomFilteredLucenePostings_0.tmd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944536 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944537 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Lucene80_0.dvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944538 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_TestBloomFilteredLucenePostings_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944538 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_MockRandom_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944539 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.kdm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944539 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944540 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Direct_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944541 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.kdi&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944541 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Direct_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944542 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.fdm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944543 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944543 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944544 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Lucene80_0.dvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944545 INFO  (qtp1654441188-33659) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_TestBloomFilteredLucenePostings_0.blm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944545 INFO  (qtp1654441188-33655) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_MockRandom_0.pos&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944546 INFO  (qtp1654441188-33657) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_TestBloomFilteredLucenePostings_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944547 INFO  (qtp1654441188-33658) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_Direct_0.tmd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1944547 INFO  (qtp1654441188-33656) [n:127.0.0.1:36289_solr 
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ] 
o.a.s.c.S.Request [cdcr-source_shard1_replica_n1]  webapp=/solr 
path=/replication 
params={generation=11&qt=/replication&file=_0_TestBloomFilteredLucenePostings_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=

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

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> 1978371 WARN  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[40933F3B4A58C69B]-SendThread(127.0.0.1:36661))
 [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for 
session 0x1015985798c0001.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1015985798c0001, 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 0x1015985798c0001, 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> 1978472 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>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        2       /solr/overseer/queue
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> 1978475 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[40933F3B4A58C69B])
 [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:36661
   [junit4]   2> 1978475 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[40933F3B4A58C69B])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36661
   [junit4]   2> 1978475 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[40933F3B4A58C69B])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36661
   [junit4]   2> 1978475 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[40933F3B4A58C69B])
 [     ] o.a.s.SolrTestCaseJ4 ###Ending testConvertClusterToCdcrAndBootstrap
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CdcrBootstrapTest 
-Dtests.method=testConvertClusterToCdcrAndBootstrap 
-Dtests.seed=40933F3B4A58C69B -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.badapples=true -Dtests.locale=nn-NO -Dtests.timezone=Europe/Luxembourg 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   12.0s J2 | 
CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find a healthy node to handle the request.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([40933F3B4A58C69B:9744104CFE075EDC]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1165)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:1048)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
   [junit4]    >        at 
org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap(CdcrBootstrapTest.java:124)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] IGNOR/A 0.00s J2 | 
CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.cdcr.CdcrBootstrapTest_40933F3B4A58C69B-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{_root_=PostingsFormat(name=Direct), 
xyz=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), 
id=PostingsFormat(name=MockRandom)}, 
docValues:{_version_=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=881, 
maxMBSortInHeap=6.253649508201021, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=nn-NO, 
timezone=Europe/Luxembourg
   [junit4]   2> NOTE: Linux 4.15.0-142-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=179492240,total=512229376
   [junit4]   2> NOTE: All tests run in this JVM: [MoveReplicaTest, 
BadIndexSchemaTest, TestSimComputePlanAction, ExplicitHLLTest, 
TestSortableTextField, ConvertedLegacyTest, TestIntervalFaceting, 
SearchRateTriggerTest, BlockDirectoryTest, DeleteInactiveReplicaTest, 
TestClassicSimilarityFactory, TestSolrCoreSnapshots, 
TestSchemaSimilarityResource, TestManagedSchema, PluginInfoTest, 
TestDocumentBuilder, TestReplicaProperties, DirectoryFactoriesTest, 
StressHdfsTest, RemoteQueryErrorTest, PingRequestHandlerTest, 
TestCollectionAPI, TestRandomDVFaceting, MetricTriggerIntegrationTest, 
TermVectorComponentDistributedTest, XMLAtomicUpdateMultivalueTest, 
HighlighterWithoutStoredIdTest, HttpSolrCallGetCoreTest, NumberUtilsTest, 
TestWordDelimiterFilterFactory, AddBlockUpdateTest, TestSimUtils, 
StatsReloadRaceTest, MetricsConfigTest, TestCharFilters, 
TestSnapshotCoreBackup, Tagger2Test, EchoParamsTest, AutoScalingHandlerTest, 
DocValuesMultiTest, RankQueryTest, AsyncCallRequestStatusResponseTest, 
TestCloudJSONFacetJoinDomain, TestIncrementalCoreBackup, RootFieldTest, 
TestComponentsName, CloudReplicaSourceTest, TestSha256AuthenticationProvider, 
TestCloudSchemaless, TestCaffeineCache, BJQParserTest, TestAnalyzedSuggestions, 
TestImplicitCoreProperties, TestExtendedDismaxParser, 
CoreMergeIndexesAdminHandlerTest, TestLegacyNumericRangeQueryBuilder, 
TestShortCircuitedRequests, TestHttpServletCarrier, ActionThrottleTest, 
SmileWriterTest, TestCursorMarkWithoutUniqueKey, SolrRequestParserTest, 
TestReqParamsAPI, SolrRrdBackendFactoryTest, TestSolrIndexConfig, 
PeerSyncReplicationTest, RestartWhileUpdatingTest, BasicDistributedZk2Test, 
TestSlowCompositeReaderWrapper, TestPullReplicaWithAuth, 
DefaultValueUpdateProcessorTest, ZkDynamicConfigTest, 
CrossCollectionJoinQueryTest, ZookeeperReadAPITest, TestSimNodeLostTrigger, 
TestJsonRangeFacets, UUIDFieldTest, InfoHandlerTest, ZkStateWriterTest, 
DistributedMLTComponentTest, PurgeGraphTest, TestPerFieldSimilarity, 
TestManagedResourceStorage, BasicAuthOnSingleNodeTest, SolrIndexMetricsTest, 
ShardTermsTest, XmlUpdateRequestHandlerTest, TestConfigsApi, 
TestExpandComponent, NodeLostTriggerIntegrationTest, TestStressThreadBackup, 
TestJsonFacetRefinement, TestTermsQParserPlugin, OverseerModifyCollectionTest, 
TestStressLiveNodes, SpellingQueryConverterTest, 
DistributedSpellCheckComponentTest, TestManagedStopFilterFactory, 
TestFastOutputStream, TestSolrCloudWithHadoopAuthPlugin, SSLMigrationTest, 
TestSolrCoreParser, TestBackupRepositoryFactory, ResourceLoaderTest, 
TestFieldTypeCollectionResource, StatelessScriptUpdateProcessorFactoryTest, 
CurrencyFieldTypeTest, NumericFieldsTest, HdfsBasicDistributedZkTest, 
TestMinMaxOnMultiValuedField, TestCSVLoader, SystemCollectionCompatTest, 
DateMathParserTest, ConcurrentCreateRoutedAliasTest, TestRealTimeGet, 
TestFiltering, OutputWriterTest, SampleTest, SolrInfoBeanTest, 
TestDistributedGrouping, TestSimpleTrackingShardHandler, 
TestSolrCoreProperties, TestTolerantSearch, TestTrie, TokenizerChainTest, 
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, 
AddReplicaTest, BasicDistributedZkTest, BasicZkTest, 
ChaosMonkeyNothingIsSafeTest, ChaosMonkeySafeLeaderTest, CleanupOldIndexTest, 
CloudExitableDirectoryReaderTest, ConnectionManagerTest, DeleteReplicaTest, 
DocValuesNotIndexedTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, 
FullSolrCloudDistribCmdsTest, HttpPartitionTest, SolrCloudExampleTest, 
TestCloudPseudoReturnFields, TestCloudRecovery2, TestConfigSetsAPIShareSchema, 
TestCryptoKeys, TestHashPartitioner, TestRandomFlRTGCloud, 
TestSolrCloudWithSecureImpersonation, TestTolerantUpdateProcessorCloud, 
TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, ZkNodePropsTest, 
ZkShardTermsTest, CollectionsAPIDistributedZkTest, NodeLostTriggerTest, 
RestoreTriggerStateTest, SystemLogListenerTest, TriggerEventQueueTest, 
TestSimDistributedQueue, BaseCdcrDistributedZkTest, CdcrBidirectionalTest, 
CdcrBootstrapTest]
   [junit4] Completed [645/939 (1!)] on J2 in 41.64s, 4 tests, 1 error, 1 
skipped <<< FAILURES!

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

Reply via email to