Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25974/
Java: 64bit/jdk-11.0.6 -XX:+UseCompressedOops -XX:+UseSerialGC

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

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

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[https://127.0.0.1:44815/solr/.system]
        at 
__randomizedtesting.SeedInfo.seed([AA2F694AC30C53E8:DADACAE3A3C4FA9E]: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:566)
        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:834)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred 
while waiting response from server at: https://127.0.0.1:44815/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 
java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:448)
        at 
java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68)
        at 
java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1103)
        at 
java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:823)
        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 14111 lines...]
   [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest
   [junit4]   2> 342288 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 342288 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/data-dir-128-001
   [junit4]   2> 342288 WARN  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 342288 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 342288 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) 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> 342289 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 342289 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001
   [junit4]   2> 342289 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 342289 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 342289 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 342389 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:38825
   [junit4]   2> 342389 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:38825
   [junit4]   2> 342389 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38825
   [junit4]   2> 342389 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 38825
   [junit4]   2> 342390 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342391 INFO  (zkConnectionManagerCallback-2523-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342391 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342392 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342393 INFO  (zkConnectionManagerCallback-2525-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342393 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342394 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342394 INFO  (zkConnectionManagerCallback-2527-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342394 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.6+10
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 342502 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.6+10
   [junit4]   2> 342505 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 342505 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 342505 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 342505 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 342505 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2575e4a6{/solr,null,AVAILABLE}
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4f57c0e4{/solr,null,AVAILABLE}
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@c8ba132{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:34479}
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.s.Server Started @342530ms
   [junit4]   2> 342506 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34479}
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@754a9d04{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:44815}
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.s.Server Started @342530ms
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44815}
   [junit4]   2> 342507 ERROR (jetty-launcher-2528-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr
   [junit4]   2> 342507 ERROR (jetty-launcher-2528-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-03-09T22:47:32.675206Z
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-03-09T22:47:32.675284Z
   [junit4]   2> 342507 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342508 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342508 INFO  (zkConnectionManagerCallback-2530-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342508 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342508 INFO  (zkConnectionManagerCallback-2532-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342508 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342509 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 342509 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 342612 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 342613 WARN  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6cd48cad[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342613 WARN  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6cd48cad[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342614 WARN  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3c0bb2d7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342614 WARN  (jetty-launcher-2528-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3c0bb2d7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342614 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38825/solr
   [junit4]   2> 342615 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342616 INFO  (zkConnectionManagerCallback-2539-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342616 INFO  (jetty-launcher-2528-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342712 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 342713 WARN  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@20f510d9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342713 WARN  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@20f510d9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342714 WARN  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6ac96033[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342714 WARN  (jetty-launcher-2528-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6ac96033[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 342714 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38825/solr
   [junit4]   2> 342715 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342716 INFO  (zkConnectionManagerCallback-2546-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342716 INFO  (jetty-launcher-2528-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342812 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 342813 INFO  (zkConnectionManagerCallback-2548-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342813 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 342839 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:34479_solr
   [junit4]   2> 342840 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.Overseer Overseer 
(id=72150357678030855-127.0.0.1:34479_solr-n_0000000000) starting
   [junit4]   2> 342841 INFO  
(OverseerStateUpdate-72150357678030855-127.0.0.1:34479_solr-n_0000000000) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:34479_solr
   [junit4]   2> 342841 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34479_solr
   [junit4]   2> 342842 INFO  (zkCallback-2547-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 342842 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 342842 WARN  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_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> 342847 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 342856 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34479.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342859 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34479.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342859 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34479.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342860 INFO  (jetty-launcher-2528-thread-1) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node1/.
   [junit4]   2> 342912 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 342913 INFO  (zkConnectionManagerCallback-2554-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342913 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 342914 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 342915 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:44815_solr as DOWN
   [junit4]   2> 342916 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 342916 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44815_solr
   [junit4]   2> 342916 INFO  (zkCallback-2547-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 342916 INFO  (zkCallback-2553-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 342916 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 342917 WARN  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_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> 342921 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 342929 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342933 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342933 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 342933 INFO  (jetty-launcher-2528-thread-2) 
[n:127.0.0.1:44815_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/.
   [junit4]   2> 342943 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 342944 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342944 INFO  (zkConnectionManagerCallback-2563-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342944 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342945 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 342945 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:38825/solr ready
   [junit4]   2> 342955 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat
   [junit4]   2> 342955 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 342956 INFO  (zkConnectionManagerCallback-2568-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 342956 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 342956 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 342957 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:38825/solr ready
   [junit4]   2> 342965 INFO  (qtp1131498775-9359) [n:127.0.0.1:34479_solr     
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 342967 INFO  (qtp1131498775-9359) [n:127.0.0.1:34479_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 342973 INFO  (qtp1131498775-9361) [n:127.0.0.1:34479_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:44815_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 342975 INFO  
(OverseerCollectionConfigSetProcessor-72150357678030855-127.0.0.1:34479_solr-n_0000000000)
 [n:127.0.0.1:34479_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> 342975 INFO  
(OverseerThreadFactory-3594-thread-2-processing-n:127.0.0.1:34479_solr) 
[n:127.0.0.1:34479_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 343076 WARN  
(OverseerThreadFactory-3594-thread-2-processing-n:127.0.0.1:34479_solr) 
[n:127.0.0.1:34479_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> 343078 INFO  
(OverseerStateUpdate-72150357678030855-127.0.0.1:34479_solr-n_0000000000) 
[n:127.0.0.1:34479_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":"https://127.0.0.1:44815/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44815_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 343078 INFO  
(OverseerStateUpdate-72150357678030855-127.0.0.1:34479_solr-n_0000000000) 
[n:127.0.0.1:34479_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":"https://127.0.0.1:44815/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44815_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 343288 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343289 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343292 WARN  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
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> 343293 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343293 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343296 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343296 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343297 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343297 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343309 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343309 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343310 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343310 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343311 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343311 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 343311 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/.system_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/./.system_shard1_replica_n2/data/]
   [junit4]   2> 343311 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343311 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343312 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 343312 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/./.system_shard1_replica_n1/data/]
   [junit4]   2> 343335 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 343335 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343335 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 343336 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@c454638[.system_shard1_replica_n2] 
main]
   [junit4]   2> 343336 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2007f69d[.system_shard1_replica_n1] 
main]
   [junit4]   2> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343337 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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 
1660728433448058880
   [junit4]   2> 343338 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343338 INFO  
(searcherExecutor-3603-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_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@c454638[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 343339 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343339 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 2 ms
   [junit4]   2> 343339 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343339 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343339 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343339 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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 
1660728433450156032
   [junit4]   2> 343341 INFO  
(searcherExecutor-3604-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:44815_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@2007f69d[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 343341 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343341 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 343341 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343842 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343842 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343842 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:44815/solr/.system_shard1_replica_n2/
   [junit4]   2> 343842 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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=https://127.0.0.1:44815/solr START 
replicas=[https://127.0.0.1:44815/solr/.system_shard1_replica_n1/] nUpdates=100
   [junit4]   2> 343842 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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=https://127.0.0.1:44815/solr DONE. 
 We have no versions.  sync failed.
   [junit4]   2> 343848 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 343849 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343849 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343849 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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/72150357678030856-core_node4-n_0000000000
   [junit4]   2> 343849 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n2/ shard1
   [junit4]   2> 343950 INFO  (zkCallback-2553-thread-3) [     ] 
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> 343950 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 343951 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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=662
   [junit4]   2> 344051 INFO  (zkCallback-2553-thread-3) [     ] 
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> 344051 INFO  (zkCallback-2553-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> 344343 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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=1055
   [junit4]   2> 344344 INFO  (qtp1131498775-9361) [n:127.0.0.1:34479_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> 344443 INFO  (zkCallback-2547-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> 344443 INFO  (zkCallback-2553-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> 344443 INFO  (zkCallback-2553-thread-3) [     ] 
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> 344444 INFO  (qtp1131498775-9361) [n:127.0.0.1:34479_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:44815_solr&wt=javabin&version=2}
 status=0 QTime=1471
   [junit4]   2> 344444 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[AA2F694AC30C53E8]) [     
] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
   [junit4]   2> 344451 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344461 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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=https://127.0.0.1:44815/solr/.system_shard1_replica_n2/&wt=javabin&version=2}{add=[170c17b65d4T29vt5fg4gnwlbt1g0ptb43p2u
 (1660728434616172544)]} 0 0
   [junit4]   2> 344461 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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=[170c17b65d4T29vt5fg4gnwlbt1g0ptb43p2u 
(1660728434616172544)]} 0 11
   [junit4]   2> 344462 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1660728434627706880,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 344462 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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@16a5e118 
commitCommandVersion:1660728434627706880
   [junit4]   2> 344463 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1660728434628755456,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 344463 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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@31166056 
commitCommandVersion:1660728434628755456
   [junit4]   2> 344464 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1a6ecb1d[.system_shard1_replica_n2] 
main]
   [junit4]   2> 344464 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@d770792[.system_shard1_replica_n1] 
main]
   [junit4]   2> 344465 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 344465 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 344465 INFO  
(searcherExecutor-3604-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:44815_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@d770792[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={os=Linux,
 os.version=5.3.0-40-generic, java.runtime.version=11.0.6+10, os.arch=amd64, 
source=flush, lucene.version=9.0.0, java.vm.version=11.0.6+10, 
java.version=11.0.6, timestamp=1583794054632, 
java.vendor=AdoptOpenJDK}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 344465 INFO  
(searcherExecutor-3603-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_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@1a6ecb1d[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={os=Linux,
 os.version=5.3.0-40-generic, java.runtime.version=11.0.6+10, os.arch=amd64, 
source=flush, lucene.version=9.0.0, java.vm.version=11.0.6+10, 
java.version=11.0.6, timestamp=1583794054631, 
java.vendor=AdoptOpenJDK}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 344466 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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=https://127.0.0.1:44815/solr/.system_shard1_replica_n2/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 2
   [junit4]   2> 344466 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 4
   [junit4]   2> 344472 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344473 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344474 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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=0
   [junit4]   2> 344476 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344476 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344478 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344478 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344479 INFO  (Thread-2028) [     ] o.a.s.c.SolrCore config 
update listener called for core .system_shard1_replica_n1
   [junit4]   2> 344479 INFO  (Thread-2028) [     ] o.a.s.c.SolrCore config 
update listener called for core .system_shard1_replica_n2
   [junit4]   2> 344479 INFO  (Thread-2028) [     ] o.a.s.c.SolrCore core 
reload .system_shard1_replica_n2
   [junit4]   2> 344481 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344497 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344498 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344498 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344518 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44815.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@3a96af3
   [junit4]   2> 344518 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/.system_shard1_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001/tempDir-001/node2/./.system_shard1_replica_n2/data/]
   [junit4]   2> 344539 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344539 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 344540 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@49e7df61[.system_shard1_replica_n2] 
main]
   [junit4]   2> 344540 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344541 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344541 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344541 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344541 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344542 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344543 INFO  
(searcherExecutor-3613-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_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@49e7df61[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={os=Linux,
 os.version=5.3.0-40-generic, java.runtime.version=11.0.6+10, os.arch=amd64, 
source=flush, lucene.version=9.0.0, java.vm.version=11.0.6+10, 
java.version=11.0.6, timestamp=1583794054631, 
java.vendor=AdoptOpenJDK}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 344543 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4068bea5[.system_shard1_replica_n2] 
main]
   [junit4]   2> 344544 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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> 344545 INFO  
(searcherExecutor-3613-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_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@4068bea5[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.vendor=AdoptOpenJDK,
 os.version=5.3.0-40-generic, java.runtime.version=11.0.6+10, os.arch=amd64, 
source=flush, lucene.version=9.0.0, java.vm.version=11.0.6+10, 
java.version=11.0.6, timestamp=1583794054631, 
os=Linux}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
   [junit4]   2> 344546 INFO  (Thread-2028) [     ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 344550 INFO  (Thread-2028) [     ] o.a.s.s.IndexSchema 
[.system_shard1_replica_n2] Schema name=_system collection or core
   [junit4]   2> 344552 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344552 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344552 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344552 INFO  (Thread-2028) [     ] o.a.s.s.IndexSchema Loaded 
schema _system collection or core/1.1 with uniqueid field id
   [junit4]   2> 344552 INFO  (Thread-2028) [     ] o.a.s.c.CoreContainer 
Reloading SolrCore '.system_shard1_replica_n2' using configuration from 
configset .system
   [junit4]   2> 344553 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344553 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344553 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344553 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344554 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344554 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344554 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344554 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344554 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344555 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344555 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344555 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344555 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344555 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344555 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344555 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344555 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344555 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344556 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344556 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344556 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344556 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344556 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344557 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344557 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344557 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344557 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344557 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344557 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344557 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344557 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344557 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344558 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344558 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344558 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344558 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344558 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344558 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344558 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344558 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344559 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344559 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344559 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344559 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344559 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344559 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344559 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344559 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344559 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344560 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344560 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344560 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344560 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344560 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344560 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344562 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344562 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344562 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344562 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344563 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344563 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344563 INFO  (qtp984645145-9368) [n:127.0.0.1:44815_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> 344563 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344563 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344564 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344564 INFO  (qtp984645145-9369) [n:127.0.0.1:44815_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> 344564 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 344564 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344564 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344564 INFO  (qtp984645145-9371) [n:127.0.0.1:44815_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> 344564 ERROR 
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.

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

 c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ due to: 
java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1
   [junit4]   2> 480701 WARN  
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1
   [junit4]   2> 480702 WARN  
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1
   [junit4]   2> 480702 WARN  
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1
   [junit4]   2> 480702 WARN  
(managedSchemaExecutor-3617-thread-1-processing-n:127.0.0.1:44815_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:44815_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get 
/schema/zkversion from https://127.0.0.1:44815/solr/.system_shard1_replica_n1/ 
due to: java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
https://127.0.0.1:44815/solr/.system_shard1_replica_n1
   [junit4]   2> 480710 WARN  (qtp984645145-9380) [n:127.0.0.1:44815_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> 480710 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Took 136166.0ms for 1 replicas to apply schema 
update version 2 for collection .system
   [junit4]   2> 480711 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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=136235
   [junit4]   2> 480711 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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@124e64c3
   [junit4]   2> 480711 WARN  (qtp984645145-9380) [n:127.0.0.1:44815_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> 480711 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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@124e64c3
   [junit4]   2> 480711 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() .
   [junit4]   2> 480711 INFO  (qtp984645145-9380) [n:127.0.0.1:44815_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@600076e7 commitCommandVersion:0
   [junit4]   2> 480713 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 480916 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/aliases.json
   [junit4]   2>        5       /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>        16      /solr/collections/.system/state.json
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        7       /solr/clusterprops.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>        11      /solr/live_nodes
   [junit4]   2>        9       /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> 480917 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:38825
   [junit4]   2> 480917 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38825
   [junit4]   2> 480917 INFO  
(SUITE-SystemCollectionCompatTest-seed#[AA2F694AC30C53E8]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 38825
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_AA2F694AC30C53E8-001
   [junit4]   2> Mar 09, 2020 10:49:51 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=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@da1b0bc),
 locale=ca-FR, timezone=Europe/Luxembourg
   [junit4]   2> NOTE: Linux 5.3.0-40-generic amd64/AdoptOpenJDK 11.0.6 
(64-bit)/cpus=16,threads=1,free=220847880,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: 
[SignificantTermsQParserPluginTest, TestCharFilters, SliceStateTest, 
TestSSLRandomization, TestSolrConfigHandler, WrapperMergePolicyFactoryTest, 
ZookeeperStatusHandlerTest, TestHashQParserPlugin, 
TestPerFieldSimilarityWithDefaultOverride, TestMultiValuedNumericRangeQuery, 
TestSimLargeCluster, SpellCheckComponentTest, DateRangeFieldTest, 
DeleteStatusTest, HttpTriggerListenerTest, TestSolrCloudWithKerberosAlt, 
CreateRoutedAliasTest, AtomicUpdatesTest, UUIDUpdateProcessorFallbackTest, 
TermsComponentTest, EchoParamsTest, TestSimComputePlanAction, 
TestDocBasedVersionConstraints, DefaultValueUpdateProcessorTest, 
TestMissingGroups, TestSubQueryTransformer, UUIDFieldTest, 
TestDelegationWithHadoopAuth, TestCorePropertiesReload, LargeFieldTest, 
HdfsBasicDistributedZkTest, HttpSolrCallGetCoreTest, 
TestCloudPhrasesIdentificationComponent, TestJsonFacets, 
NodeAddedTriggerIntegrationTest, TestExportWriter, TestCollectionAPI, 
StatsReloadRaceTest, TestManagedSchema, SchemaApiFailureTest, 
TestSchemaManager, SolrCoreCheckLockOnStartupTest, CoreAdminHandlerTest, 
TestFastOutputStream, TestExactStatsCache, TestSuggestSpellingConverter, 
BadIndexSchemaTest, CleanupOldIndexTest, TestPseudoReturnFields, 
TestStandardQParsers, CdcrReplicationHandlerTest, TestConfigOverlay, 
TestComplexPhraseLeadingWildcard, TestOrdValues, 
PhrasesIdentificationComponentTest, TestLuceneIndexBackCompat, 
HdfsRestartWhileUpdatingTest, InfoHandlerTest, SystemCollectionCompatTest]
   [junit4] Completed [398/905 (1!)] on J0 in 139.25s, 1 test, 1 error <<< 
FAILURES!

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

[repro] Revision: 44bdfb2a07053c3b3f280541bdb25642f8fbbdd9

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line:  ant test  -Dtestcase=SystemCollectionCompatTest 
-Dtests.method=testBackCompat -Dtests.seed=AA2F694AC30C53E8 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ca-FR 
-Dtests.timezone=Europe/Luxembourg -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[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 3128 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.SystemCollectionCompatTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=AA2F694AC30C53E8 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ca-FR 
-Dtests.timezone=Europe/Luxembourg -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...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