Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/4234/
1 tests failed. FAILED: org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat Error Message: No live SolrServers available to handle this request:[http://127.0.0.1:42150/solr/.system] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:42150/solr/.system] at __randomizedtesting.SeedInfo.seed([B01066AB46A66217:C0E5C502266ECB61]:0) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:345) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1143) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:906) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:838) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.cloud.SystemCollectionCompatTest.setupSystemCollection(SystemCollectionCompatTest.java:118) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:976) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826) at java.base/java.lang.Thread.run(Thread.java:834) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:42150/solr/.system at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296) ... 43 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/java.net.SocketInputStream.socketRead0(Native Method) at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140) at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137) at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153) at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259) at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163) at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125) at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272) at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186) at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110) at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564) ... 47 more Build Log: [...truncated 12603 lines...] [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest [junit4] 2> 127391 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 127392 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/data-dir-7-001 [junit4] 2> 127392 WARN (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=21 numCloses=21 [junit4] 2> 127392 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 127393 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) 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> 127396 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001 [junit4] 2> 127396 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 127397 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 127397 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 127497 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:34266 [junit4] 2> 127497 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:34266 [junit4] 2> 127497 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34266 [junit4] 2> 127497 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34266 [junit4] 2> 127500 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 127502 INFO (zkConnectionManagerCallback-144-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 127502 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 127506 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 127508 INFO (zkConnectionManagerCallback-146-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 127508 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 127508 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 127510 INFO (zkConnectionManagerCallback-148-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 127510 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 127617 WARN (jetty-launcher-149-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23 [junit4] 2> 127617 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 127617 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 127618 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS [junit4] 2> 127619 WARN (jetty-launcher-149-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23 [junit4] 2> 127619 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 127619 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 127619 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 127619 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 127619 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS [junit4] 2> 127619 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 127620 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 127620 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 127620 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 127620 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2d91740{/solr,null,AVAILABLE} [junit4] 2> 127620 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7889f2fe{/solr,null,AVAILABLE} [junit4] 2> 127630 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1f9e2f83{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42150} [junit4] 2> 127630 INFO (jetty-launcher-149-thread-1) [ ] o.e.j.s.Server Started @127676ms [junit4] 2> 127630 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42150} [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@607e47c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36343} [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.e.j.s.Server Started @127676ms [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36343} [junit4] 2> 127631 ERROR (jetty-launcher-149-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 127631 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 127631 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 127631 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 127631 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr [junit4] 2> 127631 ERROR (jetty-launcher-149-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 127631 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-13T02:18:34.151406Z [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr [junit4] 2> 127631 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-13T02:18:34.151576Z [junit4] 2> 127632 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 127645 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 127647 INFO (zkConnectionManagerCallback-151-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 127647 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 127647 INFO (zkConnectionManagerCallback-153-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 127647 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 127659 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 127659 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 129714 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 129723 WARN (jetty-launcher-149-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@27ad7e10[provider=null,keyStore=null,trustStore=null] [junit4] 2> 129723 WARN (jetty-launcher-149-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@27ad7e10[provider=null,keyStore=null,trustStore=null] [junit4] 2> 129726 WARN (jetty-launcher-149-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2e4d8c0e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 129726 WARN (jetty-launcher-149-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2e4d8c0e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 129728 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34266/solr [junit4] 2> 129749 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 129751 INFO (zkConnectionManagerCallback-161-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 129751 INFO (jetty-launcher-149-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 129855 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 129857 INFO (zkConnectionManagerCallback-163-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 129857 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 130059 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:36343_solr [junit4] 2> 130060 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.Overseer Overseer (id=72276212271742982-127.0.0.1:36343_solr-n_0000000000) starting [junit4] 2> 130076 INFO (OverseerStateUpdate-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:36343_solr [junit4] 2> 130076 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36343_solr [junit4] 2> 130077 INFO (OverseerStateUpdate-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 130100 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 130249 WARN (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_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> 130395 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 130495 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36343.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 130550 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36343.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 130550 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36343.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 130552 INFO (jetty-launcher-149-thread-2) [n:127.0.0.1:36343_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node2/. [junit4] 2> 132248 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 132250 WARN (jetty-launcher-149-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@51184deb[provider=null,keyStore=null,trustStore=null] [junit4] 2> 132250 WARN (jetty-launcher-149-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@51184deb[provider=null,keyStore=null,trustStore=null] [junit4] 2> 132254 WARN (jetty-launcher-149-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6bc4053[provider=null,keyStore=null,trustStore=null] [junit4] 2> 132254 WARN (jetty-launcher-149-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6bc4053[provider=null,keyStore=null,trustStore=null] [junit4] 2> 132256 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34266/solr [junit4] 2> 132256 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 132258 INFO (zkConnectionManagerCallback-173-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 132266 INFO (jetty-launcher-149-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 132369 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 132371 INFO (zkConnectionManagerCallback-175-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 132371 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 132394 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 132398 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:42150_solr as DOWN [junit4] 2> 132399 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 132399 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42150_solr [junit4] 2> 132400 INFO (zkCallback-162-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 132401 INFO (zkCallback-174-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 132402 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 132403 WARN (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_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> 132457 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 132501 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 132530 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 132530 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 132532 INFO (jetty-launcher-149-thread-1) [n:127.0.0.1:42150_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/. [junit4] 2> 132596 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2 [junit4] 2> 132597 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 132598 INFO (zkConnectionManagerCallback-184-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 132599 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 132600 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 132602 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34266/solr ready [junit4] 2> 132670 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat [junit4] 2> 132673 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 132674 INFO (zkConnectionManagerCallback-189-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 132674 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 132684 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 132686 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34266/solr ready [junit4] 2> 132689 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 132712 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=23 [junit4] 2> 132714 INFO (qtp291099608-663) [n:127.0.0.1:42150_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:42150_solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 132740 INFO (OverseerThreadFactory-174-thread-2-processing-n:127.0.0.1:36343_solr) [n:127.0.0.1:36343_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system [junit4] 2> 132740 INFO (OverseerCollectionConfigSetProcessor-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_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> 132845 WARN (OverseerThreadFactory-174-thread-2-processing-n:127.0.0.1:36343_solr) [n:127.0.0.1:36343_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> 132850 INFO (OverseerStateUpdate-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:42150/solr";, [junit4] 2> "node_name":"127.0.0.1:42150_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 132853 INFO (OverseerStateUpdate-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:42150/solr";, [junit4] 2> "node_name":"127.0.0.1:42150_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 133057 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133072 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133096 WARN (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version. [junit4] 2> 133096 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133104 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133146 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133146 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133151 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 133163 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 133168 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133175 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133184 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133184 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133186 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133197 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133197 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133198 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 133198 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.core..system.shard1.replica_n2' (registry 'solr.core..system.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 133199 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [[.system_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/.system_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/./.system_shard1_replica_n2/data/] [junit4] 2> 133199 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/./.system_shard1_replica_n1/data/] [junit4] 2> 133456 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133456 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133456 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133456 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133471 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133471 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 133473 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c71c84e[.system_shard1_replica_n2] main] [junit4] 2> 133478 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133478 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 133480 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@75495e4d[.system_shard1_replica_n1] main] [junit4] 2> 133495 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133495 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133495 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133496 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133498 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133499 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133500 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133500 INFO (qtp291099608-664) [n:127.0.0.1:42150_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 1658386194125291520 [junit4] 2> 133556 INFO (searcherExecutor-186-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_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@c71c84e[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 133579 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133594 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133595 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133604 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133606 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 133624 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 133627 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133627 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 23 ms [junit4] 2> 133648 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133648 INFO (qtp291099608-665) [n:127.0.0.1:42150_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 1658386194280480768 [junit4] 2> 133652 INFO (searcherExecutor-187-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:42150_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@75495e4d[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 133665 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 133666 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 134127 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134127 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134127 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:42150/solr/.system_shard1_replica_n2/ [junit4] 2> 134127 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:42150/solr START replicas=[http://127.0.0.1:42150/solr/.system_shard1_replica_n1/] nUpdates=100 [junit4] 2> 134128 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:42150/solr DONE. We have no versions. sync failed. [junit4] 2> 134139 INFO (qtp291099608-741) [n:127.0.0.1:42150_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=8 [junit4] 2> 134139 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134139 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134139 INFO (qtp291099608-664) [n:127.0.0.1:42150_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/72276212271742984-core_node4-n_0000000000 [junit4] 2> 134141 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:42150/solr/.system_shard1_replica_n2/ shard1 [junit4] 2> 134245 INFO (zkCallback-174-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> 134246 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134249 INFO (qtp291099608-664) [n:127.0.0.1:42150_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=1177 [junit4] 2> 134370 INFO (zkCallback-174-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> 134370 INFO (zkCallback-174-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> 134692 INFO (qtp291099608-665) [n:127.0.0.1:42150_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=1635 [junit4] 2> 134738 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 134744 INFO (OverseerCollectionConfigSetProcessor-72276212271742982-127.0.0.1:36343_solr-n_0000000000) [n:127.0.0.1:36343_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 134793 INFO (zkCallback-174-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> 134793 INFO (zkCallback-174-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> 134793 INFO (qtp291099608-663) [n:127.0.0.1:42150_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:42150_solr&wt=javabin&version=2} status=0 QTime=2079 [junit4] 2> 134794 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[B01066AB46A66217]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system [junit4] 2> 134828 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 134833 INFO (qtp291099608-663) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:42150/solr/.system_shard1_replica_n2/&wt=javabin&version=2}{add=[1703c575524T44xlz8sgr23yus7cpdzggvfiu (1658386195496828928)]} 0 2 [junit4] 2> 134834 INFO (qtp291099608-741) [n:127.0.0.1:42150_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=[1703c575524T44xlz8sgr23yus7cpdzggvfiu (1658386195496828928)]} 0 26 [junit4] 2> 134835 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1658386195525140480,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 134836 INFO (qtp291099608-664) [n:127.0.0.1:42150_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@68655438 commitCommandVersion:1658386195525140480 [junit4] 2> 134837 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1658386195527237632,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 134837 INFO (qtp291099608-665) [n:127.0.0.1:42150_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@26680481 commitCommandVersion:1658386195527237632 [junit4] 2> 134857 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6b45bea5[.system_shard1_replica_n2] main] [junit4] 2> 134858 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 134859 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@76d6a8b8[.system_shard1_replica_n1] main] [junit4] 2> 134880 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 134882 INFO (searcherExecutor-186-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_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@6b45bea5[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.version=11.0.4, java.vm.version=11.0.4+10-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.4+10-LTS, os.version=4.4.0-170-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1581560321358}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 134883 INFO (searcherExecutor-187-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:42150_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@76d6a8b8[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.version=11.0.4, java.vm.version=11.0.4+10-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.4+10-LTS, os.version=4.4.0-170-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1581560321376}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 134883 INFO (qtp291099608-665) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:42150/solr/.system_shard1_replica_n2/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 46 [junit4] 2> 134892 INFO (qtp291099608-664) [n:127.0.0.1:42150_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 57 [junit4] 2> 134909 INFO (qtp291099608-663) [n:127.0.0.1:42150_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=14 [junit4] 2> 134929 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 134932 INFO (qtp291099608-665) [n:127.0.0.1:42150_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 params={wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 134953 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 134955 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 134967 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135005 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135007 INFO (Thread-73) [ ] o.a.s.c.SolrCore config update listener called for core .system_shard1_replica_n1 [junit4] 2> 135008 INFO (Thread-73) [ ] o.a.s.c.SolrCore config update listener called for core .system_shard1_replica_n2 [junit4] 2> 135018 INFO (Thread-73) [ ] o.a.s.c.SolrCore core reload .system_shard1_replica_n2 [junit4] 2> 135023 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135199 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 135215 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135215 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135500 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42150.solr.core..system.shard1.replica_n2' (registry 'solr.core..system.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3b342412 [junit4] 2> 135500 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [[.system_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/.system_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001/tempDir-001/node1/./.system_shard1_replica_n2/data/] [junit4] 2> 135786 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135786 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 135807 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@50b708b4[.system_shard1_replica_n2] main] [junit4] 2> 135826 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135826 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135826 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135827 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135827 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135831 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135858 INFO (searcherExecutor-196-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_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@50b708b4[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.version=11.0.4, java.vm.version=11.0.4+10-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.4+10-LTS, os.version=4.4.0-170-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1581560321358}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 135860 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c4d86aa[.system_shard1_replica_n2] main] [junit4] 2> 135867 INFO (qtp291099608-664) [n:127.0.0.1:42150_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> 135890 INFO (searcherExecutor-196-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_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@1c4d86aa[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.version=11.0.4, java.vm.version=11.0.4+10-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.4+10-LTS, os.version=4.4.0-170-generic, java.vendor=Oracle Corporation, os=Linux, timestamp=1581560321358}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 135891 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 135891 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 135891 INFO (qtp291099608-741) [n:127.0.0.1:42150_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=20 [junit4] 2> 135892 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 135894 INFO (Thread-73) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 135910 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135911 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135911 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135911 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 135930 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 135931 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 135931 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 135931 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 135954 INFO (Thread-73) [ ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 135958 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 135959 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 135959 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 135959 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 135979 INFO (Thread-73) [ ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id [junit4] 2> 135979 INFO (Thread-73) [ ] o.a.s.c.CoreContainer Reloading SolrCore '.system_shard1_replica_n2' using configuration from configset .system [junit4] 2> 135991 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135991 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135991 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 135992 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136003 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136003 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136003 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136004 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136043 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136043 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136043 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136044 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136044 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136045 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136045 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136045 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136046 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136047 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136047 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136047 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136059 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136060 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136060 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136060 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136061 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136062 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136062 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136062 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136079 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136080 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136080 INFO (qtp291099608-663) [n:127.0.0.1:42150_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=16 [junit4] 2> 136080 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136081 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136082 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136082 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136082 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136083 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136100 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136100 INFO (qtp291099608-665) [n:127.0.0.1:42150_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=17 [junit4] 2> 136100 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136133 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136133 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136133 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136133 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136161 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136162 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136162 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136162 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136163 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136164 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136164 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136172 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136193 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136194 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136194 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136194 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136214 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136214 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136214 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136215 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136230 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136230 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136231 INFO (qtp291099608-665) [n:127.0.0.1:42150_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> 136231 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136250 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136251 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136251 INFO (qtp291099608-663) [n:127.0.0.1:42150_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> 136251 ERROR (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 136254 INFO (qtp291099608-741) [n:127.0.0.1:42150_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> 136255 INFO (qtp291099608-741) [n:127.0.0.1:42150_so [...truncated too long message...] stem_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 264412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 265412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 266412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 267412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 268412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 269412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 270412 WARN (managedSchemaExecutor-200-thread-1-processing-n:127.0.0.1:42150_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:42150/solr/.system_shard1_replica_n1/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:42150/solr/.system_shard1_replica_n1 [junit4] 2> 270935 INFO (httpUriRequest-67665-thread-1-processing-x:.system_shard1_replica_n2 r:core_node4 n:127.0.0.1:42150_solr http:////127.0.0.1:42150//solr//.system_shard1_replica_n1 c:.system s:shard1) [n:127.0.0.1:42150_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 {}->http://127.0.0.1:42150: Socket closed [junit4] 2> 270935 INFO (httpUriRequest-67665-thread-1-processing-x:.system_shard1_replica_n2 r:core_node4 n:127.0.0.1:42150_solr http:////127.0.0.1:42150//solr//.system_shard1_replica_n1 c:.system s:shard1) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.h.i.e.RetryExec Retrying request to {}->http://127.0.0.1:42150 [junit4] 2> 270940 WARN (qtp291099608-664) [n:127.0.0.1:42150_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> 270940 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Took 135079.0ms for 1 replicas to apply schema update version 2 for collection .system [junit4] 2> 270940 INFO (qtp291099608-664) [n:127.0.0.1:42150_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=136003 [junit4] 2> 270940 INFO (qtp291099608-664) [n:127.0.0.1:42150_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@2d9b516f [junit4] 2> 270940 WARN (qtp291099608-664) [n:127.0.0.1:42150_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> 270940 INFO (qtp291099608-664) [n:127.0.0.1:42150_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@2d9b516f [junit4] 2> 270941 INFO (qtp291099608-664) [n:127.0.0.1:42150_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() . [junit4] 2> 270941 INFO (qtp291099608-664) [n:127.0.0.1:42150_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@59ff2960 commitCommandVersion:0 [junit4] 2> 270944 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer. [junit4] 2> 271148 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 7 /solr/clusterprops.json [junit4] 2> 7 /solr/aliases.json [junit4] 2> 6 /solr/collections/.system/terms/shard1 [junit4] 2> 4 /solr/configs/.system/managed-schema [junit4] 2> 2 /solr/configs/.system [junit4] 2> 2 /solr/packages.json [junit4] 2> 2 /solr/security.json [junit4] 2> 2 /solr/collections/.system/collectionprops.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 14 /solr/collections/.system/state.json [junit4] 2> 7 /solr/clusterstate.json [junit4] 2> 6 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 26 /solr/overseer/queue [junit4] 2> 18 /solr/collections [junit4] 2> 11 /solr/live_nodes [junit4] 2> 10 /solr/overseer/collection-queue-work [junit4] 2> [junit4] 2> 271150 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:34266 [junit4] 2> 271150 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34266 [junit4] 2> 271150 INFO (SUITE-SystemCollectionCompatTest-seed#[B01066AB46A66217]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 34266 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_B01066AB46A66217-001 [junit4] 2> Feb 13, 2020 2:20:57 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {id=FST50, type=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{timestamp_l=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Asserting), time_l=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=661, maxMBSortInHeap=6.879171011868408, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@172ce2ea), locale=ccp, timezone=Etc/GMT+8 [junit4] 2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=8,threads=1,free=183027176,total=532676608 [junit4] 2> NOTE: All tests run in this JVM: [TestRuleBasedAuthorizationPlugin, ReplicationFactorTest, IndexBasedSpellCheckerTest, TestHttpServletCarrier, TestSubQueryTransformerCrossCore, TestUpdate, SystemCollectionCompatTest] [junit4] Completed [33/904 (1!)] on J0 in 144.66s, 1 test, 1 error <<< FAILURES! [...truncated 55438 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: builds-unsubscr...@lucene.apache.org For additional commands, e-mail: builds-h...@lucene.apache.org
