Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25569/
Java: 64bit/jdk-12.0.2 -XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions 
-XX:+UseShenandoahGC

1 tests failed.
FAILED:  org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat

Error Message:
No live SolrServers available to handle this 
request:[http://127.0.0.1:37153/solr/.system]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[http://127.0.0.1:37153/solr/.system]
        at 
__randomizedtesting.SeedInfo.seed([8C349218C856CADC:FCC131B1A89E63AA]:0)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:345)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1143)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:906)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:838)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
        at 
org.apache.solr.cloud.SystemCollectionCompatTest.setupSystemCollection(SystemCollectionCompatTest.java:118)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:976)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:835)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred 
while waiting response from server at: http://127.0.0.1:37153/solr/.system
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
        ... 43 more
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.base/java.net.SocketInputStream.socketRead0(Native Method)
        at 
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
        at 
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
        at 
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
        at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
        ... 47 more




Build Log:
[...truncated 13070 lines...]
   [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest
   [junit4]   2> 40098 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/data-dir-8-001
   [junit4]   2> 40098 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 40099 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 40099 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 40099 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001
   [junit4]   2> 40099 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 40099 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 40099 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 40199 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:46025
   [junit4]   2> 40199 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46025
   [junit4]   2> 40199 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46025
   [junit4]   2> 40199 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 46025
   [junit4]   2> 40203 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40207 INFO  (zkConnectionManagerCallback-189-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40207 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40211 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40213 INFO  (zkConnectionManagerCallback-191-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40213 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40213 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40220 INFO  (zkConnectionManagerCallback-193-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40220 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40327 WARN  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 40327 WARN  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 12.0.2+10
   [junit4]   2> 40327 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 12.0.2+10
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 40337 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 40341 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6cd7af89{/solr,null,AVAILABLE}
   [junit4]   2> 40341 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1dc8efdf{/solr,null,AVAILABLE}
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@53107e3c{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:44921}
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.e.j.s.Server Started @40366ms
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44921}
   [junit4]   2> 40342 ERROR (jetty-launcher-194-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 40342 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr
   [junit4]   2> 40343 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-02-02T14:43:20.315978Z
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@30b27346{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:37153}
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.e.j.s.Server Started @40369ms
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37153}
   [junit4]   2> 40345 ERROR (jetty-launcher-194-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr
   [junit4]   2> 40345 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-02-02T14:43:20.318789Z
   [junit4]   2> 40353 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40353 INFO  (zkConnectionManagerCallback-196-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40353 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40354 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 40361 INFO  (zkConnectionManagerCallback-198-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40361 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40366 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 40558 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 40559 WARN  (jetty-launcher-194-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@77f6cfa1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40559 WARN  (jetty-launcher-194-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@77f6cfa1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40562 WARN  (jetty-launcher-194-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@34d3fdad[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40562 WARN  (jetty-launcher-194-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@34d3fdad[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40563 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46025/solr
   [junit4]   2> 40563 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40565 INFO  (zkConnectionManagerCallback-205-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40565 INFO  (jetty-launcher-194-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40620 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 40621 WARN  (jetty-launcher-194-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3fa1053b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40621 WARN  (jetty-launcher-194-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3fa1053b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40623 WARN  (jetty-launcher-194-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4f731841[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40623 WARN  (jetty-launcher-194-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4f731841[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 40624 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46025/solr
   [junit4]   2> 40625 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40626 INFO  (zkConnectionManagerCallback-212-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40626 INFO  (jetty-launcher-194-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40669 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 40671 INFO  (zkConnectionManagerCallback-214-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40671 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 40704 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:44921_solr
   [junit4]   2> 40704 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.Overseer Overseer 
(id=72117750358605831-127.0.0.1:44921_solr-n_0000000000) starting
   [junit4]   2> 40707 INFO  
(OverseerStateUpdate-72117750358605831-127.0.0.1:44921_solr-n_0000000000) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:44921_solr
   [junit4]   2> 40707 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44921_solr
   [junit4]   2> 40707 INFO  
(OverseerStateUpdate-72117750358605831-127.0.0.1:44921_solr-n_0000000000) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 40708 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 40709 WARN  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_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> 40716 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 40729 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44921.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40733 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44921.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40734 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44921.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40734 INFO  (jetty-launcher-194-thread-1) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node1/.
   [junit4]   2> 40769 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 40770 INFO  (zkConnectionManagerCallback-220-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40770 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 40773 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 40775 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:37153_solr as DOWN
   [junit4]   2> 40775 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 40775 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37153_solr
   [junit4]   2> 40776 INFO  (zkCallback-213-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 40776 INFO  (zkCallback-219-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 40777 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 40777 WARN  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_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> 40783 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 40795 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40799 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40799 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 40800 INFO  (jetty-launcher-194-thread-2) 
[n:127.0.0.1:37153_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/.
   [junit4]   2> 40814 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 40821 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40821 INFO  (zkConnectionManagerCallback-229-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40821 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40822 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 40822 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46025/solr ready
   [junit4]   2> 40839 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat
   [junit4]   2> 40841 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 40845 INFO  (zkConnectionManagerCallback-234-thread-1) [     ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 40845 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 40845 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 40846 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46025/solr ready
   [junit4]   2> 40849 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr     ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 40853 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=4
   [junit4]   2> 40855 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr     ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
maxShardsPerNode=2&name=.system&nrtReplicas=2&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37153_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 40861 INFO  
(OverseerCollectionConfigSetProcessor-72117750358605831-127.0.0.1:44921_solr-n_0000000000)
 [n:127.0.0.1:44921_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> 40861 INFO  
(OverseerThreadFactory-192-thread-2-processing-n:127.0.0.1:44921_solr) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 40963 WARN  
(OverseerThreadFactory-192-thread-2-processing-n:127.0.0.1:44921_solr) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.a.c.CreateCollectionCmd Specified number 
of replicas of 2 on collection .system is higher than the number of Solr 
instances currently live or live and part of your createNodeSet(1). It's 
unusual to run two replica of the same slice on the same Solr-instance.
   [junit4]   2> 40965 INFO  
(OverseerStateUpdate-72117750358605831-127.0.0.1:44921_solr-n_0000000000) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:37153/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 40966 INFO  
(OverseerStateUpdate-72117750358605831-127.0.0.1:44921_solr-n_0000000000) 
[n:127.0.0.1:44921_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:37153/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 41170 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr    
x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 41170 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr    
x:.system_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 42180 WARN  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if 
you use this setting, and then Solr upgrades to a newer release of Lucene, 
sizable changes may happen. If precise back compatibility is important then you 
should instead explicitly specify an actual Lucene version.
   [junit4]   2> 42180 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 42180 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 42188 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema.xml instead
   [junit4]   2> 42188 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
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> 42190 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection 
or core
   [junit4]   2> 42190 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection 
or core
   [junit4]   2> 42203 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 42204 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 42212 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at 
/configs/.system/managed-schema
   [junit4]   2> 42212 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchema Managed schema znode at 
/configs/.system/managed-schema already exists - no need to create it
   [junit4]   2> 42213 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n2' using 
configuration from configset .system, trusted=true
   [junit4]   2> 42214 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 42214 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[.system_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/.system_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/./.system_shard1_replica_n2/data/]
   [junit4]   2> 42215 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in 
ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to 
/configs/.system/schema.xml.bak
   [junit4]   2> 42215 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using 
configuration from configset .system, trusted=true
   [junit4]   2> 42215 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 42215 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[.system_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/./.system_shard1_replica_n1/data/]
   [junit4]   2> 42244 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 42244 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 42244 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 42244 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 42245 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs; 
   [junit4]   2> 42245 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs; 
   [junit4]   2> 42245 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 42245 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 42249 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3c6a52b2[.system_shard1_replica_n1] 
main]
   [junit4]   2> 42249 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@26924b18[.system_shard1_replica_n2] 
main]
   [junit4]   2> 42250 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/.system
   [junit4]   2> 42250 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/.system
   [junit4]   2> 42250 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/.system
   [junit4]   2> 42250 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/.system
   [junit4]   2> 42250 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/.system/managed-schema
   [junit4]   2> 42250 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/.system/managed-schema
   [junit4]   2> 42250 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 42250 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 0 from ZooKeeper
   [junit4]   2> 42251 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 42251 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1657436480181633024
   [junit4]   2> 42253 INFO  
(searcherExecutor-201-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [.system_shard1_replica_n2] 
Registered new searcher Searcher@26924b18[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 42253 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection 
or core
   [junit4]   2> 42255 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/.system/terms/shard1 to Terms{values={core_node4=0}, version=0}
   [junit4]   2> 42255 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/.system/leaders/shard1
   [junit4]   2> 42257 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 42257 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 42257 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 6 ms
   [junit4]   2> 42258 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 42258 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1657436480188973056
   [junit4]   2> 42260 INFO  
(searcherExecutor-202-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node3 
x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] 
Registered new searcher Searcher@3c6a52b2[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 42261 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/.system/terms/shard1 to Terms{values={core_node3=0, core_node4=0}, 
version=1}
   [junit4]   2> 42261 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/.system/leaders/shard1
   [junit4]   2> 42758 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 42758 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 42758 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:37153/solr/.system_shard1_replica_n2/
   [junit4]   2> 42759 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync 
PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:37153/solr START 
replicas=[http://127.0.0.1:37153/solr/.system_shard1_replica_n1/] nUpdates=100
   [junit4]   2> 42759 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync 
PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:37153/solr DONE.  
We have no versions.  sync failed.
   [junit4]   2> 42761 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 42761 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidate
   [junit4]   2> 42761 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 42761 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/.system/leaders/shard1/leader after winning as 
/collections/.system/leader_elect/shard1/election/72117750358605832-core_node4-n_0000000000
   [junit4]   2> 42762 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n2/ shard1
   [junit4]   2> 42864 INFO  (zkCallback-219-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 42864 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 42866 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n2&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1696
   [junit4]   2> 42966 INFO  (zkCallback-219-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 42966 INFO  (zkCallback-219-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 43264 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2094
   [junit4]   2> 43265 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_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> 43364 INFO  (zkCallback-219-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 43364 INFO  (zkCallback-219-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] 
for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 43365 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={maxShardsPerNode=2&name=.system&nrtReplicas=2&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37153_solr&wt=javabin&version=2}
 status=0 QTime=2509
   [junit4]   2> 43365 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8C349218C856CADC]) [     
] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
   [junit4]   2> 43376 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/.system/terms/shard1 to Terms{values={core_node3=1, core_node4=1}, 
version=2}
   [junit4]   2> 43383 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37153/solr/.system_shard1_replica_n2/&wt=javabin&version=2}{add=[170065b2c4bT7gm7l2rf329gmlw3574zl75vr
 (1657436481352892416)]} 0 2
   [junit4]   2> 43384 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n2]  webapp=/solr 
path=/update 
params={wt=javabin&version=2}{add=[170065b2c4bT7gm7l2rf329gmlw3574zl75vr 
(1657436481352892416)]} 0 16
   [junit4]   2> 43386 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1657436481371766784,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 43387 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@386a035a 
commitCommandVersion:1657436481371766784
   [junit4]   2> 43389 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1657436481374912512,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 43389 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@79776be 
commitCommandVersion:1657436481374912512
   [junit4]   2> 43405 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@57d82f57[.system_shard1_replica_n2] 
main]
   [junit4]   2> 43405 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@31bd4706[.system_shard1_replica_n1] 
main]
   [junit4]   2> 43406 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 43406 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 43407 INFO  
(searcherExecutor-201-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [.system_shard1_replica_n2] 
Registered new searcher Searcher@57d82f57[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={source=flush,
 lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2, 
timestamp=1580654603370, java.vendor=AdoptOpenJDK, os=Linux, 
os.version=5.3.0-26-generic, java.runtime.version=12.0.2+10, os.arch=amd64}])))}
   [junit4]   2> 43407 INFO  
(searcherExecutor-202-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node3 
x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] 
Registered new searcher Searcher@31bd4706[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={source=flush,
 lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2, 
timestamp=1580654603370, java.vendor=AdoptOpenJDK, os=Linux, 
os.version=5.3.0-26-generic, java.runtime.version=12.0.2+10, os.arch=amd64}])))}
   [junit4]   2> 43408 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:37153/solr/.system_shard1_replica_n2/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 19
   [junit4]   2> 43409 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n2]  webapp=/solr 
path=/update 
params={_stateVer_=.system:6&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 23
   [junit4]   2> 43414 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 43416 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43420 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.S.Request 
[.system_shard1_replica_n2]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 43425 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SchemaManager managed schema loaded . version : 1 
   [junit4]   2> 43427 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection 
or core
   [junit4]   2> 43430 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 43433 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ZkController Persisted config data to node 
/configs/.system/schema.xml.bak 
   [junit4]   2> 43433 INFO  (Thread-123) [     ] o.a.s.c.SolrCore config 
update listener called for core .system_shard1_replica_n1
   [junit4]   2> 43434 INFO  (Thread-123) [     ] o.a.s.c.SolrCore config 
update listener called for core .system_shard1_replica_n2
   [junit4]   2> 43434 INFO  (Thread-123) [     ] o.a.s.c.SolrCore core reload 
.system_shard1_replica_n2
   [junit4]   2> 43437 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 43444 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection 
or core
   [junit4]   2> 43447 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid 
field id
   [junit4]   2> 43447 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.CoreContainer Reloading SolrCore '.system_shard1_replica_n2' using 
configuration from configset .system
   [junit4]   2> 43472 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37153.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 43472 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[.system_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/.system_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/./.system_shard1_replica_n2/data/]
   [junit4]   2> 43498 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs; 
   [junit4]   2> 43498 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 43500 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2a227e34[.system_shard1_replica_n2] 
main]
   [junit4]   2> 43501 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/.system
   [junit4]   2> 43501 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/.system
   [junit4]   2> 43501 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/.system/managed-schema
   [junit4]   2> 43501 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43501 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 43504 INFO  
(searcherExecutor-211-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [.system_shard1_replica_n2] 
Registered new searcher Searcher@2a227e34[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={source=flush,
 lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2, 
timestamp=1580654603370, java.vendor=AdoptOpenJDK, os=Linux, 
os.version=5.3.0-26-generic, java.runtime.version=12.0.2+10, os.arch=amd64}])))}
   [junit4]   2> 43504 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 43505 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@56e34649[.system_shard1_replica_n2] 
main]
   [junit4]   2> 43508 INFO  
(searcherExecutor-211-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [.system_shard1_replica_n2] 
Registered new searcher Searcher@56e34649[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={source=flush,
 lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2, 
timestamp=1580654603370, os=Linux, java.vendor=AdoptOpenJDK, 
os.version=5.3.0-26-generic, java.runtime.version=12.0.2+10, os.arch=amd64}])))}
   [junit4]   2> 43509 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 1 replicas to apply 
schema update version 2 for collection .system
   [junit4]   2> 43510 INFO  (Thread-123) [     ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 43515 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43515 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43515 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 43517 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43519 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43519 INFO  (Thread-123) [     ] o.a.s.s.IndexSchema 
[.system_shard1_replica_n2] Schema name=_system collection or core
   [junit4]   2> 43519 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43519 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43520 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43521 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43522 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43522 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 43523 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43524 INFO  (Thread-123) [     ] o.a.s.s.IndexSchema Loaded 
schema _system collection or core/1.1 with uniqueid field id
   [junit4]   2> 43524 INFO  (Thread-123) [     ] o.a.s.c.CoreContainer 
Reloading SolrCore '.system_shard1_replica_n2' using configuration from 
configset .system
   [junit4]   2> 43525 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43525 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43525 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43526 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43527 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43527 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43527 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43528 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43529 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43530 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43530 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43530 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43532 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43532 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43532 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43533 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43539 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43540 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43540 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43540 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43542 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43542 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43542 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43542 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43543 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43543 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43543 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43544 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43545 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43545 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43545 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43545 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43546 INFO  (Thread-123) [n:127.0.0.1:37153_solr c:.system 
s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 'solr_37153.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@166ef15a
   [junit4]   2> 43547 INFO  (Thread-123) [n:127.0.0.1:37153_solr c:.system 
s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[.system_shard1_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/.system_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001/tempDir-001/node2/./.system_shard1_replica_n2/data/]
   [junit4]   2> 43550 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43550 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43550 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43551 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43559 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43562 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43562 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 43566 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43573 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43574 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43574 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 43575 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43580 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43580 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43580 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43581 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43582 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43582 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43582 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43583 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43584 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43584 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43584 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43584 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43585 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43585 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43585 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43586 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43587 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43587 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43587 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43587 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43588 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43588 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43588 INFO  (qtp1047894776-814) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43588 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43589 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43589 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43589 INFO  (qtp1047894776-806) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 43590 ERROR 
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 43591 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, 
currentVersion=0) before returning version!
   [junit4]   2> 43591 INFO  (qtp1047894776-823) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 43591 INFO  (qtp1047894776-

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

ava.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179478 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179478 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179479 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179479 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179479 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179479 WARN  
(managedSchemaExecutor-215-thread-1-processing-n:127.0.0.1:37153_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:37153_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from http://127.0.0.1:37153/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:37153/solr/.system_shard1_replica_n1
   [junit4]   2> 179481 WARN  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Core core_node4 was interrupted waiting for schema 
version 2 to propagate to 1 replicas for collection .system
   [junit4]   2> 179481 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Took 135975.0ms for 1 replicas to apply schema 
update version 2 for collection .system
   [junit4]   2> 179481 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.S.Request 
[.system_shard1_replica_n2]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=136058
   [junit4]   2> 179481 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore 
[.system_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7ca49a18
   [junit4]   2> 179481 WARN  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.SolrMetricManager Interrupted while trying to obtain lock to modify 
reporters registry: solr.core..system.shard1.replica_n2
   [junit4]   2> 179481 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection..system.shard1.leader, tag=SolrCore@7ca49a18
   [junit4]   2> 179482 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() .
   [junit4]   2> 179482 INFO  (qtp1047894776-815) [n:127.0.0.1:37153_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@45e00526 commitCommandVersion:0
   [junit4]   2> 179485 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 179687 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>        7       /solr/clusterprops.json
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        6       /solr/collections/.system/terms/shard1
   [junit4]   2>        4       /solr/configs/.system/managed-schema
   [junit4]   2>        2       /solr/configs/.system
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/collections/.system/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        14      /solr/collections/.system/state.json
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        6       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        26      /solr/overseer/queue
   [junit4]   2>        18      /solr/collections
   [junit4]   2>        12      /solr/overseer/collection-queue-work
   [junit4]   2>        11      /solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 179689 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46025
   [junit4]   2> 179689 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46025
   [junit4]   2> 179689 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8C349218C856CADC]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 46025
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.cloud.SystemCollectionCompatTest_8C349218C856CADC-001
   [junit4]   2> Feb 02, 2020 2:45:39 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3, maxDocsPerChunk=980, blockSize=7), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=3, blockSize=7)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1434c3fc),
 locale=fr-CM, timezone=America/Port-au-Prince
   [junit4]   2> NOTE: Linux 5.3.0-26-generic amd64/AdoptOpenJDK 12.0.2 
(64-bit)/cpus=16,threads=1,free=97747672,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[ScheduledTriggerIntegrationTest, ZkFailoverTest, SliceStateTest, 
TestSimNodeAddedTrigger, TestFacetMethods, TestRuleBasedAuthorizationPlugin, 
SynonymTokenizerTest, SecurityConfHandlerTest, SystemCollectionCompatTest]
   [junit4] Completed [78/900 (1!)] on J5 in 140.45s, 1 test, 1 error <<< 
FAILURES!

[...truncated 50660 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25569/consoleText

[repro] Revision: d8bc9bcfcf772dfbfb6aa39dc019b0787946707a

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops 
-XX:+UnlockExperimentalVMOptions -XX:+UseShenandoahGC"
[repro] Repro line:  ant test  -Dtestcase=SystemCollectionCompatTest 
-Dtests.method=testBackCompat -Dtests.seed=8C349218C856CADC 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr-CM 
-Dtests.timezone=America/Port-au-Prince -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8

[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       SystemCollectionCompatTest
[repro] ant compile-test

[...truncated 3150 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.SystemCollectionCompatTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions 
-XX:+UseShenandoahGC" -Dtests.seed=8C349218C856CADC -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=fr-CM -Dtests.timezone=America/Port-au-Prince 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...truncated 81 lines...]
[repro] Failures w/original seeds:
[repro]   0/5 failed: org.apache.solr.cloud.SystemCollectionCompatTest
[repro] Exiting with code 0

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

Reply via email to