Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8608/
Java: 64bit/jdk-14 -XX:+UseCompressedOops -XX:+UseG1GC

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:60155/solr/.system]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[https://127.0.0.1:60155/solr/.system]
        at 
__randomizedtesting.SeedInfo.seed([8B76EBCD30CAF289:FB83486450025BFF]: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:564)
        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:832)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred 
while waiting response from server at: https://127.0.0.1:60155/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/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:283)
        at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:309)
        at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:350)
        at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:803)
        at java.base/java.net.Socket$SocketInputStream.read(Socket.java:982)
        at 
java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457)
        at 
java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68)
        at 
java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1411)
        at 
java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:1022)
        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 13420 lines...]
   [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest
   [junit4]   2> 263921 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf'
   [junit4]   2> 263921 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\data-dir-22-001
   [junit4]   2> 263922 WARN  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
   [junit4]   2> 263922 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 263923 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 263924 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 263924 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001
   [junit4]   2> 263924 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 263925 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 263925 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 264026 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:60142
   [junit4]   2> 264026 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:60142
   [junit4]   2> 264026 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:60142
   [junit4]   2> 264026 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 60142
   [junit4]   2> 264028 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264031 INFO  (zkConnectionManagerCallback-1126-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264031 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264033 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264035 INFO  (zkConnectionManagerCallback-1128-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264035 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264036 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264037 INFO  (zkConnectionManagerCallback-1130-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264037 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 14+36-1461
   [junit4]   2> 264144 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 14+36-1461
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 264145 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 264146 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@296abd0b{/solr,null,AVAILABLE}
   [junit4]   2> 264146 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@491dabf6{/solr,null,AVAILABLE}
   [junit4]   2> 264147 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@4b6924c2{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:60156}
   [junit4]   2> 264147 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.s.Server Started @264168ms
   [junit4]   2> 264147 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60156}
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6bc16f7{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:60155}
   [junit4]   2> 264148 ERROR (jetty-launcher-1131-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.s.Server Started @264169ms
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-03-24T06:24:56.170513200Z
   [junit4]   2> 264148 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60155}
   [junit4]   2> 264149 ERROR (jetty-launcher-1131-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-03-24T06:24:56.171025700Z
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264149 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264151 INFO  (zkConnectionManagerCallback-1133-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264151 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264151 INFO  (zkConnectionManagerCallback-1135-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264151 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264151 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 264151 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 264259 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 264261 WARN  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6fff1295[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264261 WARN  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6fff1295[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264264 WARN  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4501c6a4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264264 WARN  (jetty-launcher-1131-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4501c6a4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264264 INFO  (jetty-launcher-1131-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60142/solr
   [junit4]   2> 264265 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 264267 INFO  (zkConnectionManagerCallback-1142-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264267 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 264348 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:60156_solr
   [junit4]   2> 264348 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.Overseer Overseer 
(id=72079639567532037-127.0.0.1:60156_solr-n_0000000000) starting
   [junit4]   2> 264351 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60156_solr
   [junit4]   2> 264351 INFO  
(OverseerStateUpdate-72079639567532037-127.0.0.1:60156_solr-n_0000000000) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:60156_solr
   [junit4]   2> 264355 INFO  
(OverseerStateUpdate-72079639567532037-127.0.0.1:60156_solr-n_0000000000) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 264355 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 264355 WARN  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_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> 264360 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 264360 WARN  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@63fbc4f8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264360 WARN  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@63fbc4f8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264364 WARN  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@612b848b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264364 WARN  (jetty-launcher-1131-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@612b848b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 264364 INFO  (jetty-launcher-1131-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60142/solr
   [junit4]   2> 264364 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 264367 INFO  (zkConnectionManagerCallback-1152-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264367 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 264371 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 264375 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:60155_solr as DOWN
   [junit4]   2> 264375 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 1000 transient cores
   [junit4]   2> 264375 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60155_solr
   [junit4]   2> 264378 INFO  (zkCallback-1141-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 264378 INFO  (zkCallback-1151-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 264379 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 264379 WARN  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_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> 264379 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 264406 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 264406 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60156.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264413 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60156.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264413 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60156.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264415 INFO  (jetty-launcher-1131-thread-1) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node1\.
   [junit4]   2> 264425 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264432 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264432 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264432 INFO  (jetty-launcher-1131-thread-2) 
[n:127.0.0.1:60155_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.
   [junit4]   2> 264454 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 264455 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264455 INFO  (zkConnectionManagerCallback-1162-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264455 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264460 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 264460 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:60142/solr ready
   [junit4]   2> 264478 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat
   [junit4]   2> 264479 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 264479 INFO  (zkConnectionManagerCallback-1167-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 264479 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 264484 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 264485 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:60142/solr ready
   [junit4]   2> 264497 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr     ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 264502 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=5
   [junit4]   2> 264513 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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:60155_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 264520 INFO  
(OverseerCollectionConfigSetProcessor-72079639567532037-127.0.0.1:60156_solr-n_0000000000)
 [n:127.0.0.1:60156_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> 264520 INFO  
(OverseerThreadFactory-1042-thread-2-processing-n:127.0.0.1:60156_solr) 
[n:127.0.0.1:60156_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 264628 WARN  
(OverseerThreadFactory-1042-thread-2-processing-n:127.0.0.1:60156_solr) 
[n:127.0.0.1:60156_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> 264632 INFO  
(OverseerStateUpdate-72079639567532037-127.0.0.1:60156_solr-n_0000000000) 
[n:127.0.0.1:60156_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:60155/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:60155_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 264633 INFO  
(OverseerStateUpdate-72079639567532037-127.0.0.1:60156_solr-n_0000000000) 
[n:127.0.0.1:60156_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:60155/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:60155_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 264845 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264848 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264858 WARN  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264858 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264859 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264875 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264875 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264882 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 264882 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 264885 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264885 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264891 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264891 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264894 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264894 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264894 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2\data\]
   [junit4]   2> 264895 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264895 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264896 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 264896 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n1\data\]
   [junit4]   2> 264970 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264970 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264970 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264970 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264973 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264973 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264973 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 264973 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 264974 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@44343ff9[.system_shard1_replica_n1] 
main]
   [junit4]   2> 264974 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@70201c0c[.system_shard1_replica_n2] 
main]
   [junit4]   2> 264975 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264975 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264976 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264976 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264978 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264978 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264980 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264980 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264980 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264980 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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 
1662025567569969152
   [junit4]   2> 264982 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 264982 INFO  
(searcherExecutor-1056-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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@70201c0c[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 264984 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264984 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 264985 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264985 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 5 ms
   [junit4]   2> 264986 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264986 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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 
1662025567576260608
   [junit4]   2> 264987 INFO  
(searcherExecutor-1057-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:60155_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@44343ff9[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 264988 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264988 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 264989 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265490 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265490 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265490 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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:60155/solr/.system_shard1_replica_n2/
   [junit4]   2> 265491 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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:60155/solr START 
replicas=[https://127.0.0.1:60155/solr/.system_shard1_replica_n1/] nUpdates=100
   [junit4]   2> 265491 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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:60155/solr DONE. 
 We have no versions.  sync failed.
   [junit4]   2> 265501 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 265501 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265501 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265501 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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/72079639567532038-core_node4-n_0000000000
   [junit4]   2> 265503 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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:60155/solr/.system_shard1_replica_n2/ shard1
   [junit4]   2> 265606 INFO  (zkCallback-1151-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> 265607 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 265611 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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=765
   [junit4]   2> 265710 INFO  (zkCallback-1151-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> 265710 INFO  (zkCallback-1151-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> 265997 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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=1148
   [junit4]   2> 265999 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266096 INFO  (zkCallback-1151-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> 266096 INFO  (zkCallback-1151-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> 266097 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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:60155_solr&wt=javabin&version=2}
 status=0 QTime=1584
   [junit4]   2> 266098 INFO  
(TEST-SystemCollectionCompatTest.testBackCompat-seed#[8B76EBCD30CAF289]) [     
] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
   [junit4]   2> 266111 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266131 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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:60155/solr/.system_shard1_replica_n2/&wt=javabin&version=2}{add=[1710b372f08T3ty8y4g3nu6lsi13yxzj1ye5x
 (1662025568745422848)]} 0 1
   [junit4]   2> 266131 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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=[1710b372f08T3ty8y4g3nu6lsi13yxzj1ye5x 
(1662025568745422848)]} 0 33
   [junit4]   2> 266131 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1662025568776880128,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 266131 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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@42f52e4e 
commitCommandVersion:1662025568776880128
   [junit4]   2> 266131 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1662025568776880128,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 266131 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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@fd2b339 
commitCommandVersion:1662025568776880128
   [junit4]   2> 266139 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3de1147a[.system_shard1_replica_n2] 
main]
   [junit4]   2> 266139 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2432c377[.system_shard1_replica_n1] 
main]
   [junit4]   2> 266139 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 266139 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 266139 INFO  
(searcherExecutor-1057-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) 
[n:127.0.0.1:60155_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@2432c377[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.runtime.version=14+36-1461,
 os.version=10.0, os=Windows 10, java.vendor=Oracle Corporation, 
timestamp=1585031098160, java.version=14, java.vm.version=14+36-1461, 
lucene.version=9.0.0, source=flush, 
os.arch=amd64}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 266139 INFO  
(searcherExecutor-1056-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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@3de1147a[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.runtime.version=14+36-1461,
 os.version=10.0, os=Windows 10, java.vendor=Oracle Corporation, 
timestamp=1585031098160, java.version=14, java.vm.version=14+36-1461, 
lucene.version=9.0.0, source=flush, 
os.arch=amd64}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 266139 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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:60155/solr/.system_shard1_replica_n2/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 5
   [junit4]   2> 266143 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n2]  webapp=/solr 
path=/update 
params={_stateVer_=.system:6&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 8
   [junit4]   2> 266147 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=3
   [junit4]   2> 266147 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266153 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.S.Request 
[.system_shard1_replica_n2]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266172 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266173 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 266176 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266183 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266183 INFO  (Thread-471) [     ] o.a.s.c.SolrCore config 
update listener called for core .system_shard1_replica_n2
   [junit4]   2> 266187 INFO  (Thread-471) [     ] o.a.s.c.SolrCore core reload 
.system_shard1_replica_n2
   [junit4]   2> 266194 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266210 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 266210 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266210 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266239 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60155.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 266239 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2\data\]
   [junit4]   2> 266307 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266307 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 266307 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@552bf8ea[.system_shard1_replica_n2] 
main]
   [junit4]   2> 266311 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266311 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266311 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266311 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266311 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266315 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266315 INFO  
(searcherExecutor-1066-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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@552bf8ea[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.runtime.version=14+36-1461,
 os.version=10.0, os=Windows 10, java.vendor=Oracle Corporation, 
timestamp=1585031098160, java.version=14, java.vm.version=14+36-1461, 
lucene.version=9.0.0, source=flush, 
os.arch=amd64}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 266315 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@783cde3[.system_shard1_replica_n2] 
main]
   [junit4]   2> 266319 INFO  
(searcherExecutor-1066-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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@783cde3[.system_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.runtime.version=14+36-1461,
 os.version=10.0, java.vendor=Oracle Corporation, os=Windows 10, 
timestamp=1585031098160, java.version=14, java.vm.version=14+36-1461, 
lucene.version=9.0.0, source=flush, 
os.arch=amd64}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
   [junit4]   2> 266321 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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> 266326 INFO  (Thread-471) [     ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 266332 INFO  (Thread-471) [     ] o.a.s.s.IndexSchema Schema 
name=_system collection or core
   [junit4]   2> 266347 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266347 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266347 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266347 INFO  (Thread-471) [     ] o.a.s.s.IndexSchema Loaded 
schema _system collection or core/1.1 with uniqueid field id
   [junit4]   2> 266347 INFO  (Thread-471) [     ] o.a.s.c.CoreContainer 
Reloading SolrCore '.system_shard1_replica_n2' using configuration from 
configset .system
   [junit4]   2> 266348 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266349 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266350 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266350 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266350 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266351 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266351 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266351 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266352 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266352 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266352 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266352 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266354 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266358 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266359 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266359 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266359 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266364 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266376 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266376 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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=12
   [junit4]   2> 266377 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266377 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266379 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266379 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=2
   [junit4]   2> 266379 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266383 INFO  (Thread-471) [n:127.0.0.1:60155_solr c:.system 
s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 'solr_60155.solr.core..system.shard1.replica_n2' (registry 
'solr.core..system.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@76bf8f1
   [junit4]   2> 266383 INFO  (Thread-471) [n:127.0.0.1:60155_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 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001\tempDir-001\node2\.\.system_shard1_replica_n2\data\]
   [junit4]   2> 266384 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266384 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266384 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266387 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266391 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266391 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266391 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266391 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266399 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266399 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266399 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266401 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266403 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266403 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266403 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266403 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266404 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266404 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266404 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266404 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266406 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266406 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266406 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266406 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266407 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266407 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266407 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266407 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266409 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266409 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266409 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266410 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266411 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266411 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266411 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266412 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266413 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266413 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266413 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266413 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266415 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3782) [n:127.0.0.1:60155_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> 266415 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266415 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3786) [n:127.0.0.1:60155_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> 266415 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266415 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266415 INFO  (qtp205815175-3850) [n:127.0.0.1:60155_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> 266420 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica 
https://127.0.0.1:60155/solr/.system_shard1_replica_n1/ returned schema version 
0 and has not applied schema version 2
   [junit4]   2> 266422 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266423 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_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> 266423 INFO  (qtp205815175-3784) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 266428 ERROR 
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_solr c:.system

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

a/zkversion from https://127.0.0.1:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 393280 WARN  
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 395476 WARN  
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 397576 WARN  
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 399584 WARN  
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 401608 WARN  
(managedSchemaExecutor-1070-thread-1-processing-n:127.0.0.1:60155_solr 
x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) 
[n:127.0.0.1:60155_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:60155/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:60155/solr/.system_shard1_replica_n1
   [junit4]   2> 402034 INFO  
(httpUriRequest-120124-thread-1-processing-x:.system_shard1_replica_n2 
r:core_node4 n:127.0.0.1:60155_solr 
https:////127.0.0.1:60155//solr//.system_shard1_replica_n1 c:.system s:shard1) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.h.i.e.RetryExec I/O exception 
(java.net.SocketException) caught when processing request to 
{s}->https://127.0.0.1:60155: Socket closed
   [junit4]   2> 402034 INFO  
(httpUriRequest-120124-thread-1-processing-x:.system_shard1_replica_n2 
r:core_node4 n:127.0.0.1:60155_solr 
https:////127.0.0.1:60155//solr//.system_shard1_replica_n1 c:.system s:shard1) 
[n:127.0.0.1:60155_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n2 ] o.a.h.i.e.RetryExec Retrying request to 
{s}->https://127.0.0.1:60155
   [junit4]   2> 402035 WARN  (qtp205815175-3788) [n:127.0.0.1:60155_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> 402035 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.s.ManagedIndexSchema Took 135718.0ms for 1 replicas to apply schema 
update version 2 for collection .system
   [junit4]   2> 402037 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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=135869
   [junit4]   2> 402037 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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@43ea46ef
   [junit4]   2> 402037 WARN  (qtp205815175-3788) [n:127.0.0.1:60155_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> 402037 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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@43ea46ef
   [junit4]   2> 402037 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_solr 
c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() .
   [junit4]   2> 402037 INFO  (qtp205815175-3788) [n:127.0.0.1:60155_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@eaa5c7 commitCommandVersion:0
   [junit4]   2> 402039 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 402242 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>        6       /solr/collections/.system/terms/shard1
   [junit4]   2>        4       /solr/configs/.system/managed-schema
   [junit4]   2>        2       /solr/configs/.system
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/collections/.system/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /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>        11      /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> 402246 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:60142
   [junit4]   2> 402246 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:60142
   [junit4]   2> 402246 INFO  
(SUITE-SystemCollectionCompatTest-seed#[8B76EBCD30CAF289]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 60142
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J3\temp\solr.cloud.SystemCollectionCompatTest_8B76EBCD30CAF289-001
   [junit4]   2> NOTE: test params are: codec=Lucene84, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3220e1fd),
 locale=ebu-KE, timezone=Africa/Lagos
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 14 
(64-bit)/cpus=6,threads=1,free=72138512,total=251658240
   [junit4]   2> NOTE: All tests run in this JVM: [TestHashPartitioner, 
TestStressCloudBlindAtomicUpdates, TestSimComputePlanAction, TestReload, 
BasicAuthOnSingleNodeTest, MoreLikeThisHandlerTest, TestFieldCacheSortRandom, 
TestSurroundQueryParser, TestOrdValues, TestExplainDocTransformer, 
BinaryUpdateRequestHandlerTest, TestPullReplicaErrorHandling, 
HdfsChaosMonkeyNothingIsSafeTest, TestTextField, TestCSVLoader, 
DistributedFacetPivotLargeTest, CoreSorterTest, TestPseudoReturnFields, 
TestCollectionsAPIViaSolrCloudCluster, CursorPagingTest, TestSmileRequest, 
TestClassicSimilarityFactory, TestLegacyFieldReuse, CdcrBidirectionalTest, 
ZkCLITest, LegacyCloudClusterPropTest, SystemCollectionCompatTest]
   [junit4] Completed [177/907 (1!)] on J3 in 140.35s, 1 test, 1 error <<< 
FAILURES!

[...truncated 47344 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8608/consoleText

[repro] Revision: 68e430445370dc9467585e5a352f471e24e89111

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"

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

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

[...truncated 3150 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.SystemCollectionCompatTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=8B76EBCD30CAF289 
-Dtests.slow=true -Dtests.locale=ebu-KE -Dtests.timezone=Africa/Lagos 
-Dtests.asserts=true -Dtests.file.encoding=Cp1252

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

[...truncated 78 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org
For additional commands, e-mail: builds-h...@lucene.apache.org

Reply via email to