Build:
https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/274/
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([8487FCCEFE15CB79:5350D3B94A4A533E]: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 14232 lines...]
[junit4] Suite: org.apache.solr.cloud.cdcr.CdcrBootstrapTest
[junit4] 2> 688938 INFO
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-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> 688938 INFO
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 688938 INFO
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/data-dir-69-001
[junit4] 2> 688938 WARN
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 688938 INFO
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 688940 INFO
(SUITE-CdcrBootstrapTest-seed#[8487FCCEFE15CB79]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] IGNOR/A 0.00s J1 |
CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster
[junit4] > Assumption #1: 'awaitsfix' test group is disabled
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-12028))
[junit4] 2> 688952 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testConvertClusterToCdcrAndBootstrap
[junit4] 2> 688952 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] 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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-target-001
[junit4] 2> 688953 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 688953 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 688953 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 688954 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 689053 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer start zk server on port: 33351
[junit4] 2> 689053 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:33351
[junit4] 2> 689053 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33351
[junit4] 2> 689053 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33351
[junit4] 2> 689054 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 689056 INFO (zkConnectionManagerCallback-8837-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689056 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 689058 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 689059 INFO (zkConnectionManagerCallback-8839-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689059 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 689060 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 689061 INFO (zkConnectionManagerCallback-8841-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689061 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 689163 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 689163 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 689163 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git:
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 689163 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7f801187{/solr,null,AVAILABLE}
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@368f1214{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:45855}
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.e.j.s.Server Started @689251ms
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:33351/solr, hostPort=45855}
[junit4] 2> 689164 ERROR (jetty-launcher-8842-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.9.0
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 689164 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2021-05-11T08:41:58.076Z
[junit4] 2> 689165 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 689166 INFO (zkConnectionManagerCallback-8844-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689166 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 689166 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 689169 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 689780 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 689781 WARN (jetty-launcher-8842-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@46d75624[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 689781 WARN (jetty-launcher-8842-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@46d75624[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 689784 WARN (jetty-launcher-8842-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@204f59d6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 689784 WARN (jetty-launcher-8842-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@204f59d6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 689785 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33351/solr
[junit4] 2> 689787 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 689788 INFO (zkConnectionManagerCallback-8855-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689788 INFO (jetty-launcher-8842-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 689890 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 689891 INFO (zkConnectionManagerCallback-8857-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 689891 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 689962 WARN (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_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> 689966 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45855_solr
[junit4] 2> 689967 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.c.Overseer Overseer
(id=72125645131546629-127.0.0.1:45855_solr-n_0000000000) starting
[junit4] 2> 689971 INFO
(OverseerStateUpdate-72125645131546629-127.0.0.1:45855_solr-n_0000000000)
[n:127.0.0.1:45855_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:45855_solr
[junit4] 2> 689971 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45855_solr
[junit4] 2> 689972 INFO
(OverseerStateUpdate-72125645131546629-127.0.0.1:45855_solr-n_0000000000)
[n:127.0.0.1:45855_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 689975 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 689975 WARN (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_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> 689990 INFO (jetty-launcher-8842-thread-1)
[n:127.0.0.1:45855_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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-target-001/node1
[junit4] 2> 689999 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 690000 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 690001 INFO (zkConnectionManagerCallback-8872-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 690001 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 690002 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 690003 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33351/solr ready
[junit4] 2> 690003 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.CdcrBootstrapTest Target zkHost = 127.0.0.1:33351/solr
[junit4] 2> 690003 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] 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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-source-001
[junit4] 2> 690003 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 690008 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 690008 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 690008 WARN (ZkTestServer Run Thread) [ ]
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 690108 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer start zk server on port: 34691
[junit4] 2> 690108 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:34691
[junit4] 2> 690108 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34691
[junit4] 2> 690108 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34691
[junit4] 2> 690109 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 690111 INFO (zkConnectionManagerCallback-8874-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 690111 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 690120 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 690121 INFO (zkConnectionManagerCallback-8876-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 690121 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 690127 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 690128 INFO (zkConnectionManagerCallback-8878-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 690128 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 690230 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 690230 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 690230 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git:
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7841df0c{/solr,null,AVAILABLE}
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@42dd6b40{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:32789}
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.e.j.s.Server Started @690318ms
[junit4] 2> 690231 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:34691/solr, hostPort=32789}
[junit4] 2> 690232 ERROR (jetty-launcher-8879-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 690232 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 690232 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.9.0
[junit4] 2> 690232 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 690232 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 690232 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2021-05-11T08:41:59.144Z
[junit4] 2> 690235 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 690239 INFO (zkConnectionManagerCallback-8881-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 690240 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 690240 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 690243 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 691186 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 691187 WARN (jetty-launcher-8879-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@7f4d8ce5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 691187 WARN (jetty-launcher-8879-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@7f4d8ce5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 691189 WARN (jetty-launcher-8879-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@3c121af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 691189 WARN (jetty-launcher-8879-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3c121af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 691190 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34691/solr
[junit4] 2> 691191 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 691195 INFO (zkConnectionManagerCallback-8892-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 691196 INFO (jetty-launcher-8879-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 691297 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 691298 INFO (zkConnectionManagerCallback-8894-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 691298 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 691349 WARN (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_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> 691353 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:32789_solr
[junit4] 2> 691354 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.Overseer Overseer
(id=72125645200687109-127.0.0.1:32789_solr-n_0000000000) starting
[junit4] 2> 691358 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:32789_solr
[junit4] 2> 691358 INFO
(OverseerStateUpdate-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[n:127.0.0.1:32789_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:32789_solr
[junit4] 2> 691359 INFO
(OverseerStateUpdate-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[n:127.0.0.1:32789_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 691360 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 691361 WARN (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_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> 691374 INFO (jetty-launcher-8879-thread-1)
[n:127.0.0.1:32789_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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-source-001/node1
[junit4] 2> 691384 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 691385 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 691386 INFO (zkConnectionManagerCallback-8909-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 691386 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 691387 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 691388 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:34691/solr ready
[junit4] 2> 691395 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 691395 INFO (zkConnectionManagerCallback-8911-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 691395 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 691398 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79]-SendThread(127.0.0.1:34691))
[ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for
session 0x1003de465620007.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1003de465620007, 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 0x1003de465620007, 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> 691504 INFO
(OverseerThreadFactory-8901-thread-1-processing-n:127.0.0.1:32789_solr)
[n:127.0.0.1:32789_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
cdcr-source
[junit4] 2> 691612 INFO
(OverseerStateUpdate-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[n:127.0.0.1:32789_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"cdcr-source_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:32789_solr",
[junit4] 2> "base_url":"http://127.0.0.1:32789/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> 691814 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691815 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 2147483647 transient cores
[junit4] 2> 691825 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 691826 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691827 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691827 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691827 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-source-001/node1/cdcr-source_shard1_replica_n1/data/]
[junit4] 2> 691875 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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.UpdateLog
[junit4] 2> 691875 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691875 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691875 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691878 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691878 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691878 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691878 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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 1699450737959895040
[junit4] 2> 691880 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 691884 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691884 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691887 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691887 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691888 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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:32789/solr/cdcr-source_shard1_replica_n1/
[junit4] 2> 691888 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 691888 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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:32789/solr/cdcr-source_shard1_replica_n1/
has no replicas
[junit4] 2> 691888 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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/72125645200687109-core_node2-n_0000000000
[junit4] 2> 691890 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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:32789/solr/cdcr-source_shard1_replica_n1/ shard1
[junit4] 2> 691995 INFO (zkCallback-8893-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> 691995 INFO (zkCallback-8893-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> 691998 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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> 692002 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_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=188
[junit4] 2> 692004 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_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> 692101 INFO (zkCallback-8893-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> 692101 INFO (zkCallback-8893-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> 692102 INFO (zkCallback-8893-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> 692102 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_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=602
[junit4] 2> 692102 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: cdcr-source
[junit4] 2> 692115 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_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> 692115 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_0
(1699450738202116096), source_1 (1699450738204213248), source_2
(1699450738204213249), source_3 (1699450738204213250), source_4
(1699450738204213251), source_5 (1699450738204213252), source_6
(1699450738204213253), source_7 (1699450738204213254), source_8
(1699450738204213255), source_9 (1699450738204213256), ... (100 adds)]} 0 6
[junit4] 2> 692364 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 692364 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 248
[junit4] 2> 692370 INFO (qtp1276808371-14769) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_100
(1699450738470551552), source_101 (1699450738472648704), source_102
(1699450738472648705), source_103 (1699450738472648706), source_104
(1699450738472648707), source_105 (1699450738472648708), source_106
(1699450738472648709), source_107 (1699450738472648710), source_108
(1699450738472648711), source_109 (1699450738472648712), ... (100 adds)]} 0 4
[junit4] 2> 692614 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 692614 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 243
[junit4] 2> 692619 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_200
(1699450738732695552), source_201 (1699450738733744128), source_202
(1699450738733744129), source_203 (1699450738733744130), source_204
(1699450738734792704), source_205 (1699450738734792705), source_206
(1699450738734792706), source_207 (1699450738734792707), source_208
(1699450738734792708), source_209 (1699450738734792709), ... (100 adds)]} 0 3
[junit4] 2> 692866 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 692866 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 247
[junit4] 2> 692871 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_300
(1699450738996936704), source_301 (1699450738997985280), source_302
(1699450738999033856), source_303 (1699450738999033857), source_304
(1699450738999033858), source_305 (1699450738999033859), source_306
(1699450738999033860), source_307 (1699450738999033861), source_308
(1699450738999033862), source_309 (1699450738999033863), ... (100 adds)]} 0 3
[junit4] 2> 693131 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 693132 INFO (qtp1276808371-14769) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 260
[junit4] 2> 693136 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_400
(1699450739275857920), source_401 (1699450739276906496), source_402
(1699450739276906497), source_403 (1699450739276906498), source_404
(1699450739276906499), source_405 (1699450739276906500), source_406
(1699450739276906501), source_407 (1699450739276906502), source_408
(1699450739276906503), source_409 (1699450739276906504), ... (100 adds)]} 0 3
[junit4] 2> 693380 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 693380 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 243
[junit4] 2> 693386 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_500
(1699450739535904768), source_501 (1699450739536953344), source_502
(1699450739538001920), source_503 (1699450739538001921), source_504
(1699450739538001922), source_505 (1699450739538001923), source_506
(1699450739538001924), source_507 (1699450739538001925), source_508
(1699450739538001926), source_509 (1699450739538001927), ... (100 adds)]} 0 4
[junit4] 2> 693506 INFO
(OverseerCollectionConfigSetProcessor-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[n:127.0.0.1:32789_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> 693636 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 693636 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 250
[junit4] 2> 693641 INFO (qtp1276808371-14769) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_600
(1699450739804340224), source_601 (1699450739805388800), source_602
(1699450739805388801), source_603 (1699450739805388802), source_604
(1699450739805388803), source_605 (1699450739805388804), source_606
(1699450739805388805), source_607 (1699450739806437376), source_608
(1699450739806437377), source_609 (1699450739806437378), ... (100 adds)]} 0 3
[junit4] 2> 693885 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 693885 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 243
[junit4] 2> 693889 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_700
(1699450740065435648), source_701 (1699450740066484224), source_702
(1699450740066484225), source_703 (1699450740066484226), source_704
(1699450740066484227), source_705 (1699450740066484228), source_706
(1699450740066484229), source_707 (1699450740066484230), source_708
(1699450740066484231), source_709 (1699450740066484232), ... (100 adds)]} 0 3
[junit4] 2> 694162 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 694162 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 272
[junit4] 2> 694167 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_800
(1699450740356939776), source_801 (1699450740357988352), source_802
(1699450740357988353), source_803 (1699450740357988354), source_804
(1699450740357988355), source_805 (1699450740357988356), source_806
(1699450740357988357), source_807 (1699450740357988358), source_808
(1699450740357988359), source_809 (1699450740357988360), ... (100 adds)]} 0 3
[junit4] 2> 694436 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 694436 INFO (qtp1276808371-14769) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 265
[junit4] 2> 694441 INFO (qtp1276808371-14770) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_900
(1699450740643201024), source_901 (1699450740644249600), source_902
(1699450740644249601), source_903 (1699450740644249602), source_904
(1699450740644249603), source_905 (1699450740644249604), source_906
(1699450740644249605), source_907 (1699450740644249606), source_908
(1699450740644249607), source_909 (1699450740644249608), ... (100 adds)]} 0 4
[junit4] 2> 694691 INFO
(searcherExecutor-8913-thread-1-processing-n:127.0.0.1:32789_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:32789_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> 694691 INFO (qtp1276808371-14768) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 250
[junit4] 2> 694692 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.CdcrBootstrapTest Adding numDocs=1000
[junit4] 2> 694692 INFO (qtp1276808371-14771) [n:127.0.0.1:32789_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:3&wt=javabin&version=2} hits=1000 status=0
QTime=0
[junit4] 2> 694694 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0
result:{maxVersionSpecified=9223372036854775807,
maxVersionEncountered=1699450740647395342, maxInHash=1699450740647395342,
versionsHash=-9003221086795273674, numVersions=1000, numDocs=1000, maxDoc=100}
[junit4] 2> 694694 INFO (qtp1276808371-14767) [n:127.0.0.1:32789_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=/get
params={qt=/get&_stateVer_=cdcr-source:3&fingerprint=true&getVersions=1000&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 694695 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 694696 INFO (zkConnectionManagerCallback-8919-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 694696 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 694800 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=647583234
[junit4] 2> 694800 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:32789_solr
[junit4] 2> 694801 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 694801 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkController Publish node=127.0.0.1:32789_solr as DOWN
[junit4] 2> 694803 INFO (coreCloseExecutor-8923-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.c.SolrCore [cdcr-source_shard1_replica_n1]
CLOSING SolrCore org.apache.solr.core.SolrCore@3f9a5020
[junit4] 2> 694803 INFO (coreCloseExecutor-8923-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.cdcr-source.shard1.replica_n1
tag=SolrCore@3f9a5020
[junit4] 2> 694803 INFO (coreCloseExecutor-8923-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.cdcr-source.shard1.leader
tag=SolrCore@3f9a5020
[junit4] 2> 694803 INFO (zkCallback-8893-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> 694803 INFO (zkCallback-8893-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> 694803 INFO (zkCallback-8893-thread-4) [ ]
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> 694804 INFO (coreCloseExecutor-8923-thread-1)
[n:127.0.0.1:32789_solr ] o.a.s.u.DirectUpdateHandler2 Committing on
IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 694807 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node tag=null
[junit4] 2> 694807 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm tag=null
[junit4] 2> 694807 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty tag=null
[junit4] 2> 694807 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.cluster tag=null
[junit4] 2> 694807 INFO (closeThreadPool-8925-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=72125645200687109-127.0.0.1:32789_solr-n_0000000000) closing
[junit4] 2> 694808 INFO
(OverseerStateUpdate-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[n:127.0.0.1:32789_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:32789_solr
[junit4] 2> 694808 INFO
(OverseerAutoScalingTriggerThread-72125645200687109-127.0.0.1:32789_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 694812 INFO (closeThreadPool-8925-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72125645200687109-127.0.0.1:32789_solr-n_0000000000) closing
[junit4] 2> 694813 INFO (zkCallback-8908-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 694913 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.Overseer Overseer
(id=72125645200687109-127.0.0.1:32789_solr-n_0000000000) closing
[junit4] 2> 694914 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.AbstractConnector Stopped ServerConnector@42dd6b40{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 694914 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7841df0c{/solr,null,STOPPED}
[junit4] 2> 694914 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 694915 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.MiniSolrCloudCluster waitForJettyToStop: 32789
[junit4] 2> 694915 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding
port=0)
[junit4] 2> 694915 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number
2 ...
[junit4] 2> 694915 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.Server jetty-9.4.34.v20201102; built:
2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm
1.8.0_281-b09
[junit4] 2> 694916 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 694916 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 694917 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 694917 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5e711e31{/solr,null,AVAILABLE}
[junit4] 2> 694917 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@38a7cd68{HTTP/1.1,
(http/1.1, h2c)}{127.0.0.1:37437}
[junit4] 2> 694917 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.s.Server Started @695004ms
[junit4] 2> 694917 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
zkHost=127.0.0.1:34691/solr, hostPort=37437}
[junit4] 2> 694917 ERROR
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 694918 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 694918 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 8.9.0
[junit4] 2> 694918 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 694918 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 694918 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2021-05-11T08:42:03.830Z
[junit4] 2> 694919 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 694919 INFO (zkConnectionManagerCallback-8927-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 694919 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 694920 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 694923 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 695344 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 695345 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@4e9a35cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 695345 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@4e9a35cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 695348 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.u.s.S.config Trusting all certificates configured for
Client@6a313a3f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 695348 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm
configured for Client@6a313a3f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 695349 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34691/solr
[junit4] 2> 695350 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 695351 INFO (zkConnectionManagerCallback-8938-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 695351 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 695452 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 695453 INFO (zkConnectionManagerCallback-8940-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 695453 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 695457 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_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> 695460 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37437_solr
[junit4] 2> 695460 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.Overseer Overseer
(id=72125645200687115-127.0.0.1:37437_solr-n_0000000001) starting
[junit4] 2> 695463 INFO
(OverseerStateUpdate-72125645200687115-127.0.0.1:37437_solr-n_0000000001)
[n:127.0.0.1:37437_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:37437_solr
[junit4] 2> 695463 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37437_solr
[junit4] 2> 695468 INFO
(OverseerStateUpdate-72125645200687115-127.0.0.1:37437_solr-n_0000000001)
[n:127.0.0.1:37437_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 695468 INFO (zkCallback-8908-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 695470 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 695470 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_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> 695485 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-source-001/node1
[junit4] 2> 695485 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[n:127.0.0.1:37437_solr ] o.a.s.c.CorePropertiesLocator Cores are:
[cdcr-source_shard1_replica_n1]
[junit4] 2> 695486 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 695491 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.9.0
[junit4] 2> 695491 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] 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> 695492 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 695493 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 695494 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] o.a.s.s.ManagedIndexSchema Created and persisted
managed schema znode at /configs/cdcr-source/managed-schema
[junit4] 2> 695496 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr ] 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> 696504 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_solr c:cdcr-source s:shard1 r:core_node2
x:cdcr-source_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.9.0
[junit4] 2> 696506 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696506 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696506 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696506 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001/cdcr-source-001/node1/cdcr-source_shard1_replica_n1/data/]
[junit4] 2> 696533 WARN
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696534 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696534 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696535 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696535 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696557 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696557 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696557 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696558 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696558 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696560 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696561 INFO
(coreLoadExecutor-8950-thread-1-processing-n:127.0.0.1:37437_solr)
[n:127.0.0.1:37437_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> 696565 INFO
(searcherExecutor-8952-thread-1-processing-n:127.0.0.1:37437_solr
x:cdcr-source_shard1_replica_n1 c:cdcr-source s:shard1 r:core_node2)
[n:127.0.0.1:37437_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> 696565 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 696565 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish -
collection: cdcr-source failOnTimeout: true timeout (sec):
[junit4] 1> replica:core_node2 rstate:active live:false
[junit4] 1> no one is recoverying
[junit4] 2> 696567 WARN (qtp1660535243-14836) [n:127.0.0.1:37437_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.h.CdcrRequestHandler Action LASTPROCESSEDVERSION sent to non-leader
replica @ cdcr-source:shard1
[junit4] 2> 696567 ERROR (qtp1660535243-14836) [n:127.0.0.1:37437_solr
c:cdcr-source s:shard1 r:core_node2 x:cdcr-source_shard1_replica_n1 ]
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Action
LASTPROCESSEDVERSION sent to non-leader replica
[junit4] 2> at
org.apache.solr.handler.CdcrRequestHandler.handleLastProcessedVersionAction(CdcrRequestHandler.java:511)
[junit4] 2> at
org.apache.solr.handler.CdcrRequestHandler.handleRequestBody(CdcrRequestHandler.java:218)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:216)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2637)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:794)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:567)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:427)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:357)
[junit4] 2> at
org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
[junit4] 2> at
org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1612)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1434)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1582)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1349)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
[junit4] 2> at
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:766)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:516)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:556)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
[junit4] 2> at
org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:773)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:905)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 696568 INFO (qtp1660535243-14836) [n:127.0.0.1:37437_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={action=LASTPROCESSEDVERSION&wt=javabin&version=2} status=400 QTime=0
[junit4] 1> replica:core_node2 rstate:down live:true
[junit4] 2> 696568 WARN (cdcr-update-log-synchronizer-8958-thread-1) [
] o.a.s.h.CdcrUpdateLogSynchronizer Caught unexpected exception
[junit4] 2> =>
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:37437/solr/cdcr-source_shard1_replica_n1:
Action LASTPROCESSEDVERSION sent to non-leader replica
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
[junit4] 2>
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:37437/solr/cdcr-source_shard1_replica_n1:
Action LASTPROCESSEDVERSION sent to non-leader replica
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
~[java/:?]
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1290) ~[java/:?]
[junit4] 2> at
org.apache.solr.handler.CdcrUpdateLogSynchronizer$UpdateLogSynchronisation.run(CdcrUpdateLogSynchronizer.java:149)
[java/:?]
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[?:1.8.0_281]
[junit4] 2> at
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [?:1.8.0_281]
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
[?:1.8.0_281]
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
[?:1.8.0_281]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[?:1.8.0_281]
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[?:1.8.0_281]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_281]
[junit4] 1> replica:core_node2 rstate:down live:true
[junit4] 1> replica:core_node2 rstate:down live:true
[junit4] 2> 696569 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection:
cdcr-source
[junit4] 2> 696570 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient request was not communication error it
seems
[junit4] 2> 696570 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient Request to collection [cdcr-source]
failed due to (510) org.apache.solr.common.SolrException: Could not find a
healthy node to handle the request., retry=0 maxRetries=5 commError=false
errorCode=510
[junit4] 2> 696570 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient Re-trying request to collection(s)
[cdcr-source] after stale state error from server.
[junit4] 2> 696570 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient request was not communication error it
seems
[junit4] 2> 696570 INFO
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient Request to collection [cdcr-source]
failed due to (510) org.apache.solr.common.SolrException: Could not find a
healthy node to handle the request., retry=1 maxRetries=5 commError=false
errorCode=510
[junit4] 2> 696570 WARN
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.s.i.BaseCloudSolrClient Re-trying request to collection(s)
[cdcr-source] after stale state error from server.
[junit4]
[...truncated too long message...]
er Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 723316 INFO (jetty-closer-9348-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 723316 INFO (jetty-closer-9348-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 723329 INFO (zkCallback-9133-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 723328 WARN
(jetty-launcher-9101-thread-2-SendThread(127.0.0.1:40683)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1003de4bb02000b.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1003de4bb02000b, 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 0x1003de4bb02000b, 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> 723330 INFO (closeThreadPool-9366-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=72125646637236232-127.0.0.1:44613_solr-n_0000000000) closing
[junit4] 2> 723338 INFO
(OverseerStateUpdate-72125646637236232-127.0.0.1:44613_solr-n_0000000000)
[n:127.0.0.1:44613_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:44613_solr
[junit4] 2> 723345 INFO
(OverseerAutoScalingTriggerThread-72125646637236232-127.0.0.1:44613_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 723345 INFO (closeThreadPool-9366-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72125646637236232-127.0.0.1:44613_solr-n_0000000000) closing
[junit4] 2> 723346 WARN
(jetty-launcher-9101-thread-1-SendThread(127.0.0.1:40683)) [ ]
o.a.z.ClientCnxn An exception was thrown while closing send thread for session
0x1003de4bb020008.
[junit4] 2> => EndOfStreamException: Unable to read additional
data from server sessionid 0x1003de4bb020008, 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 0x1003de4bb020008, 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> 723431 INFO (jetty-closer-9348-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@6e4558d7{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 723431 INFO (jetty-closer-9348-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@788eada6{/solr,null,STOPPED}
[junit4] 2> 723431 INFO (jetty-closer-9348-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 723530 INFO (jetty-closer-9348-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72125646637236232-127.0.0.1:44613_solr-n_0000000000) closing
[junit4] 2> 723531 INFO (jetty-closer-9348-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@5d648c0c{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 723532 INFO (jetty-closer-9348-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@11f2c369{/solr,null,STOPPED}
[junit4] 2> 723532 INFO (jetty-closer-9348-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 723632 INFO (jetty-closer-9348-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@466dd6ed{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 723632 INFO (jetty-closer-9348-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2ec6de19{/solr,null,STOPPED}
[junit4] 2> 723632 INFO (jetty-closer-9348-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 723633 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithMultipleReplicas-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 723835 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> 25 /solr/collections/cdcr-target/terms/shard1
[junit4] 2> 8
/solr/collections/cdcr-target/leaders/shard1/leader
[junit4] 2> 5 /solr/configs/cdcr-target/managed-schema
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/configs/cdcr-target
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 47 /solr/collections/cdcr-target/state.json
[junit4] 2> 9 /solr/collections/cdcr-target/cdcr/state/process
[junit4] 2> 5 /solr/collections/cdcr-target/cdcr/state/buffer
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 2
/solr/collections/cdcr-target/leader_elect/shard1/election/72125646637236233-core_node6-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/overseer/queue
[junit4] 2> 16 /solr/collections/cdcr-target/state.json
[junit4] 2> 12 /solr/live_nodes
[junit4] 2> 9 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 723838 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithMultipleReplicas-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:40683
[junit4] 2> 723838 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithMultipleReplicas-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40683
[junit4] 2> 723838 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithMultipleReplicas-seed#[8487FCCEFE15CB79])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 40683
[junit4] 2> 723838 INFO
(TEST-CdcrBootstrapTest.testBootstrapWithMultipleReplicas-seed#[8487FCCEFE15CB79])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testBootstrapWithMultipleReplicas
[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/J1/temp/solr.cloud.cdcr.CdcrBootstrapTest_8487FCCEFE15CB79-001
[junit4] 2> May 11, 2021 8:42:32 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87):
{_root_=PostingsFormat(name=Direct), xyz=PostingsFormat(name=LuceneFixedGap),
id=PostingsFormat(name=LuceneVarGapDocFreqInterval)},
docValues:{_version_=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=870,
maxMBSortInHeap=7.36326767712762,
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=ja,
timezone=Antarctica/Davis
[junit4] 2> NOTE: Linux 4.15.0-142-generic amd64/Oracle Corporation
1.8.0_281 (64-bit)/cpus=4,threads=1,free=275918152,total=521142272
[junit4] 2> NOTE: All tests run in this JVM: [TestStressLiveNodes,
CoreMergeIndexesAdminHandlerTest, TestReversedWildcardFilterFactory,
TestMacroExpander, TestCollectionAPI, TestStressThreadBackup,
ByteBuffersDirectoryFactoryTest, ReplicationFactorTest, StatsReloadRaceTest,
TestPartialUpdateDeduplication, DistanceUnitsTest,
PeerSyncWithIndexFingerprintCachingTest, ZkStateWriterTest,
DistributedIntervalFacetingTest, OpenExchangeRatesOrgProviderTest,
TestReplicaProperties, AssignBackwardCompatibilityTest, SolrPluginUtilsTest,
CustomHighlightComponentTest, DimensionalRoutedAliasUpdateProcessorTest,
ZkNodePropsTest, NestedShardedAtomicUpdateTest, TestScoreJoinQPScore,
SuggesterTest, PurgeGraphTest, TestJoin, MetricTriggerIntegrationTest,
ProtectedTermFilterFactoryTest, DistributedFacetPivotSmallAdvancedTest,
TestLegacyTerms, TestSimExtremeIndexing, TestSchemaVersionResource,
DirectoryFactoriesTest, TestSolrCoreSnapshots, ResponseLogComponentTest,
TestSuggestSpellingConverter, AnalyticsMergeStrategyTest,
TestCloudDeleteByQuery, TestSolrCoreProperties, SolrCLIZkUtilsTest,
TestNumericTokenStream, TestHighFrequencyDictionaryFactory, TestCrossCoreJoin,
CdcrVersionReplicationTest, TestConfigSets, SampleTest, PackageManagerCLITest,
NodeLostTriggerIntegrationTest, TestChildDocTransformer, TestRebalanceLeaders,
ConnectionReuseTest, TestFastLRUCache, BackupIdTest,
TestShortCircuitedRequests, SolrIndexSplitterTest, TriggerEventQueueTest,
HdfsRecoverLeaseTest, TestManagedSynonymFilterFactory, TestSimNodeLostTrigger,
ChaosMonkeyNothingIsSafeTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
UpdateLogTest, TestPullReplicaErrorHandling,
DocumentAnalysisRequestHandlerTest, TestDynamicFieldResource,
TestMaxScoreQueryParser, TestSimUtils, SchemaVersionSpecificBehaviorTest,
TestImplicitCoreProperties, HighlighterConfigTest, MoreLikeThisComponentTest,
TemplateUpdateProcessorTest, CdcrBootstrapTest]
[junit4] Completed [276/937 (1!)] on J1 in 35.78s, 4 tests, 1 error, 1
skipped <<< FAILURES!
[...truncated 53043 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
