Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/26026/ Java: 64bit/jdk-12.0.2 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat Error Message: No live SolrServers available to handle this request:[https://127.0.0.1:36287/solr/.system] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[https://127.0.0.1:36287/solr/.system] at __randomizedtesting.SeedInfo.seed([3F06848800D44EF1:4FF32721601CE787]:0) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:345) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1143) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:906) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:838) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.cloud.SystemCollectionCompatTest.setupSystemCollection(SystemCollectionCompatTest.java:118) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:976) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826) at java.base/java.lang.Thread.run(Thread.java:835) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: https://127.0.0.1:36287/solr/.system at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296) ... 43 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/java.net.SocketInputStream.socketRead0(Native Method) at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168) at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140) at java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:448) at java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68) at java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1132) at java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:828) 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 14818 lines...] [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest [junit4] 2> 658665 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/server/solr/configsets/_default/conf' [junit4] 2> 658665 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 658665 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/data-dir-110-001 [junit4] 2> 658665 WARN (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=92 numCloses=92 [junit4] 2> 658665 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 658665 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 658666 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001 [junit4] 2> 658666 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 658666 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 658666 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 658766 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:41529 [junit4] 2> 658766 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:41529 [junit4] 2> 658766 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41529 [junit4] 2> 658766 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41529 [junit4] 2> 658767 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658768 INFO (zkConnectionManagerCallback-5118-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658768 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 658770 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658770 INFO (zkConnectionManagerCallback-5120-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658770 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 658770 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658771 INFO (zkConnectionManagerCallback-5122-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658771 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 12.0.2+10 [junit4] 2> 658874 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 12.0.2+10 [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7d4c8e98{/solr,null,AVAILABLE} [junit4] 2> 658879 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58995842{/solr,null,AVAILABLE} [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3878d856{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:36287} [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.e.j.s.Server Started @658891ms [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36287} [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1fefea95{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:35707} [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.e.j.s.Server Started @658891ms [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35707} [junit4] 2> 658880 ERROR (jetty-launcher-5123-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 658880 ERROR (jetty-launcher-5123-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-03-16T05:53:37.050861Z [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr [junit4] 2> 658880 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-03-16T05:53:37.050912Z [junit4] 2> 658881 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658881 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658884 INFO (zkConnectionManagerCallback-5125-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658884 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 658884 INFO (zkConnectionManagerCallback-5127-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658884 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 658885 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 658886 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 658991 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 658992 WARN (jetty-launcher-5123-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@47c388c3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 658992 WARN (jetty-launcher-5123-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@47c388c3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 658993 WARN (jetty-launcher-5123-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7e35ccbe[provider=null,keyStore=null,trustStore=null] [junit4] 2> 658993 WARN (jetty-launcher-5123-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7e35ccbe[provider=null,keyStore=null,trustStore=null] [junit4] 2> 658994 INFO (jetty-launcher-5123-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41529/solr [junit4] 2> 658995 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 658995 INFO (zkConnectionManagerCallback-5134-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 658995 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 659020 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35707_solr [junit4] 2> 659021 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.Overseer Overseer (id=72186006927507461-127.0.0.1:35707_solr-n_0000000000) starting [junit4] 2> 659022 INFO (OverseerStateUpdate-72186006927507461-127.0.0.1:35707_solr-n_0000000000) [n:127.0.0.1:35707_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:35707_solr [junit4] 2> 659022 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35707_solr [junit4] 2> 659023 INFO (zkCallback-5133-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 659023 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 659023 WARN (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_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> 659028 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 659040 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35707.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659044 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35707.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659044 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35707.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659045 INFO (jetty-launcher-5123-thread-1) [n:127.0.0.1:35707_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node1/. [junit4] 2> 659091 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 659092 WARN (jetty-launcher-5123-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7bf0f1f2[provider=null,keyStore=null,trustStore=null] [junit4] 2> 659092 WARN (jetty-launcher-5123-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7bf0f1f2[provider=null,keyStore=null,trustStore=null] [junit4] 2> 659093 WARN (jetty-launcher-5123-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3aa9fa9c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 659093 WARN (jetty-launcher-5123-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3aa9fa9c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 659094 INFO (jetty-launcher-5123-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41529/solr [junit4] 2> 659095 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 659095 INFO (zkConnectionManagerCallback-5145-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 659095 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 659097 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 659098 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:36287_solr as DOWN [junit4] 2> 659098 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores [junit4] 2> 659098 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36287_solr [junit4] 2> 659098 INFO (zkCallback-5133-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 659098 INFO (zkCallback-5144-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 659099 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 659099 WARN (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_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> 659104 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 659115 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659121 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659121 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659122 INFO (jetty-launcher-5123-thread-2) [n:127.0.0.1:36287_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/. [junit4] 2> 659138 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2 [junit4] 2> 659139 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 659139 INFO (zkConnectionManagerCallback-5154-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 659139 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 659140 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 659140 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41529/solr ready [junit4] 2> 659154 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat [junit4] 2> 659156 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 659157 INFO (zkConnectionManagerCallback-5159-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 659157 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 659157 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 659158 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41529/solr ready [junit4] 2> 659168 INFO (qtp1343554780-19224) [n:127.0.0.1:35707_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 659170 INFO (qtp1343554780-19224) [n:127.0.0.1:35707_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 659176 INFO (qtp1343554780-19226) [n:127.0.0.1:35707_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:36287_solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 659178 INFO (OverseerCollectionConfigSetProcessor-72186006927507461-127.0.0.1:35707_solr-n_0000000000) [n:127.0.0.1:35707_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> 659178 INFO (OverseerThreadFactory-5159-thread-2-processing-n:127.0.0.1:35707_solr) [n:127.0.0.1:35707_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system [junit4] 2> 659280 WARN (OverseerThreadFactory-5159-thread-2-processing-n:127.0.0.1:35707_solr) [n:127.0.0.1:35707_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> 659281 INFO (OverseerStateUpdate-72186006927507461-127.0.0.1:35707_solr-n_0000000000) [n:127.0.0.1:35707_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:36287/solr";, [junit4] 2> "node_name":"127.0.0.1:36287_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 659282 INFO (OverseerStateUpdate-72186006927507461-127.0.0.1:35707_solr-n_0000000000) [n:127.0.0.1:35707_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:36287/solr";, [junit4] 2> "node_name":"127.0.0.1:36287_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 659495 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659496 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659502 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659502 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659508 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659508 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659510 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 659510 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 659513 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659513 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659514 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema [junit4] 2> 659515 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ManagedIndexSchema Managed schema znode at /configs/.system/managed-schema already exists - no need to create it [junit4] 2> 659515 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659516 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659516 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n1/data/] [junit4] 2> 659517 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] 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> 659517 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659517 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.core..system.shard1.replica_n2' (registry 'solr.core..system.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 659517 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SolrCore [[.system_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n2/data/] [junit4] 2> 659559 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659559 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659560 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659560 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 659561 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3cfa60b2[.system_shard1_replica_n1] main] [junit4] 2> 659562 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659562 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659563 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659563 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659563 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659563 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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 1661298821282398208 [junit4] 2> 659564 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659564 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659565 INFO (searcherExecutor-5173-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_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@3cfa60b2[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 659565 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659565 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 659567 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@40bdbaf0[.system_shard1_replica_n2] main] [junit4] 2> 659569 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659569 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659569 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659570 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Retrieved schema version 0 from ZooKeeper [junit4] 2> 659570 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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}, version=0} [junit4] 2> 659570 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 659572 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 659572 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms [junit4] 2> 659575 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659575 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 4 ms [junit4] 2> 659575 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 659576 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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 1661298821296029696 [junit4] 2> 659577 INFO (searcherExecutor-5174-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:36287_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@40bdbaf0[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 659579 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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=0, core_node4=0}, version=1} [junit4] 2> 659580 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660073 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 660073 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 660073 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:36287/solr/.system_shard1_replica_n1/ [junit4] 2> 660073 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n1 url=https://127.0.0.1:36287/solr START replicas=[https://127.0.0.1:36287/solr/.system_shard1_replica_n2/] nUpdates=100 [junit4] 2> 660074 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n1 url=https://127.0.0.1:36287/solr DONE. We have no versions. sync failed. [junit4] 2> 660082 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660082 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 660082 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 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> 660082 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72186006927507462-core_node3-n_0000000000 [junit4] 2> 660089 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:36287/solr/.system_shard1_replica_n1/ shard1 [junit4] 2> 660191 INFO (zkCallback-5144-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2]) [junit4] 2> 660191 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 660193 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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=697 [junit4] 2> 660293 INFO (zkCallback-5144-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2]) [junit4] 2> 660293 INFO (zkCallback-5144-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> 660584 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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=1088 [junit4] 2> 660585 INFO (qtp1343554780-19226) [n:127.0.0.1:35707_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> 660685 INFO (zkCallback-5133-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> 660685 INFO (zkCallback-5144-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2]) [junit4] 2> 660685 INFO (zkCallback-5144-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> 660685 INFO (qtp1343554780-19226) [n:127.0.0.1:35707_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:36287_solr&wt=javabin&version=2} status=0 QTime=1509 [junit4] 2> 660685 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[3F06848800D44EF1]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system [junit4] 2> 660693 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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=1, core_node4=1}, version=2} [junit4] 2> 660704 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:36287/solr/.system_shard1_replica_n1/&wt=javabin&version=2}{add=[170e1e7a228T3q0gpodz6orn33bn0oet4bd2j (1661298822466240512)]} 0 1 [junit4] 2> 660704 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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={wt=javabin&version=2}{add=[170e1e7a228T3q0gpodz6orn33bn0oet4bd2j (1661298822466240512)]} 0 11 [junit4] 2> 660705 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1661298822479872000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 660705 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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@47d14ff1 commitCommandVersion:1661298822479872000 [junit4] 2> 660705 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1661298822479872000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 660705 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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@12d1860 commitCommandVersion:1661298822479872000 [junit4] 2> 660708 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3377cef6[.system_shard1_replica_n1] main] [junit4] 2> 660708 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7306469e[.system_shard1_replica_n2] main] [junit4] 2> 660708 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 660708 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 660708 INFO (searcherExecutor-5173-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_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@3377cef6[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={timestamp=1584338018876, java.vendor=AdoptOpenJDK, os=Linux, os.version=5.3.0-40-generic, java.runtime.version=12.0.2+10, os.arch=amd64, source=flush, lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 660709 INFO (searcherExecutor-5174-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:36287_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@7306469e[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={timestamp=1584338018876, java.vendor=AdoptOpenJDK, os=Linux, os.version=5.3.0-40-generic, java.runtime.version=12.0.2+10, os.arch=amd64, source=flush, lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 660709 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:36287/solr/.system_shard1_replica_n1/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 3 [junit4] 2> 660709 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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={_stateVer_=.system:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4 [junit4] 2> 660715 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660716 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660716 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660718 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SchemaManager managed schema loaded . version : 1 [junit4] 2> 660720 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 660721 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660722 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController Persisted config data to node /configs/.system/schema.xml.bak [junit4] 2> 660723 INFO (Thread-3738) [ ] o.a.s.c.SolrCore config update listener called for core .system_shard1_replica_n2 [junit4] 2> 660723 INFO (Thread-3738) [ ] o.a.s.c.SolrCore config update listener called for core .system_shard1_replica_n1 [junit4] 2> 660723 INFO (Thread-3738) [ ] o.a.s.c.SolrCore core reload .system_shard1_replica_n1 [junit4] 2> 660725 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660729 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 660731 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660731 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Reloading SolrCore '.system_shard1_replica_n1' using configuration from configset .system [junit4] 2> 660755 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36287.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d852da6 [junit4] 2> 660755 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001/tempDir-001/node2/./.system_shard1_replica_n1/data/] [junit4] 2> 660780 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660780 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 660781 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@474cf232[.system_shard1_replica_n1] main] [junit4] 2> 660782 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660782 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660782 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660782 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660782 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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> 660784 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 660784 INFO (searcherExecutor-5183-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_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@474cf232[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={timestamp=1584338018876, java.vendor=AdoptOpenJDK, os=Linux, os.version=5.3.0-40-generic, java.runtime.version=12.0.2+10, os.arch=amd64, source=flush, lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 660785 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4a036e60[.system_shard1_replica_n1] main] [junit4] 2> 660785 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 1 replicas to apply schema update version 2 for collection .system [junit4] 2> 660786 INFO (searcherExecutor-5183-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_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@4a036e60[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={timestamp=1584338018876, os=Linux, java.vendor=AdoptOpenJDK, os.version=5.3.0-40-generic, java.runtime.version=12.0.2+10, os.arch=amd64, source=flush, lucene.version=9.0.0, java.vm.version=12.0.2+10, java.version=12.0.2}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 660787 INFO (Thread-3738) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 660792 INFO (Thread-3738) [ ] o.a.s.s.IndexSchema Schema name=_system collection or core [junit4] 2> 660793 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660793 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660793 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 660793 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660794 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660794 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660794 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660794 INFO (Thread-3738) [ ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id [junit4] 2> 660794 INFO (Thread-3738) [ ] o.a.s.c.CoreContainer Reloading SolrCore '.system_shard1_replica_n1' using configuration from configset .system [junit4] 2> 660794 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660794 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660795 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660795 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660795 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660795 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660795 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660795 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660795 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660795 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660795 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660795 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660796 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660796 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660796 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660796 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660796 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660796 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660796 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660796 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660796 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660796 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660797 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660797 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660797 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660797 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660797 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660797 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660797 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660797 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660797 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660797 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660797 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660797 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660798 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660798 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660798 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660798 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660798 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660798 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660798 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660798 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660798 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660798 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660798 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660799 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660799 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660799 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660799 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660799 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660799 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660799 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660799 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660799 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660800 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660800 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660800 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660800 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660800 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660800 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660800 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660800 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660801 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660801 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660801 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660801 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660801 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660801 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660801 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660801 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660801 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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> 660801 INFO (qtp2005021421-19234) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660801 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660802 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660802 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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> 660802 INFO (qtp2005021421-19236) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660802 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 660802 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.h.SchemaHandler REFRESHING SCHEMA (refreshIfBelowVersion=2, currentVersion=0) before returning version! [junit4] 2> 660802 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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> 660802 INFO (qtp2005021421-19233) [n:127.0.0.1:36287_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/zkversion params={refreshIfBelowVersion=2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 660802 ERROR (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r: [...truncated too long message...] plica_n2 [junit4] 2> 795611 WARN (managedSchemaExecutor-5187-thread-1-processing-n:127.0.0.1:36287_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from https://127.0.0.1:36287/solr/.system_shard1_replica_n2/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: https://127.0.0.1:36287/solr/.system_shard1_replica_n2 [junit4] 2> 796505 INFO (httpUriRequest-300686-thread-1-processing-x:.system_shard1_replica_n1 r:core_node3 n:127.0.0.1:36287_solr https:////127.0.0.1:36287//solr//.system_shard1_replica_n2 c:.system s:shard1) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec I/O exception (java.net.SocketException) caught when processing request to {s}->https://127.0.0.1:36287: Socket closed [junit4] 2> 796505 INFO (httpUriRequest-300686-thread-1-processing-x:.system_shard1_replica_n1 r:core_node3 n:127.0.0.1:36287_solr https:////127.0.0.1:36287//solr//.system_shard1_replica_n2 c:.system s:shard1) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec Retrying request to {s}->https://127.0.0.1:36287 [junit4] 2> 796507 WARN (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Core core_node3 was interrupted waiting for schema version 2 to propagate to 1 replicas for collection .system [junit4] 2> 796507 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Took 135722.0ms for 1 replicas to apply schema update version 2 for collection .system [junit4] 2> 796507 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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=135789 [junit4] 2> 796507 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@6c00fefd [junit4] 2> 796508 WARN (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Interrupted while trying to obtain lock to modify reporters registry: solr.core..system.shard1.replica_n1 [junit4] 2> 796508 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection..system.shard1.leader, tag=SolrCore@6c00fefd [junit4] 2> 796508 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() . [junit4] 2> 796508 INFO (qtp2005021421-19245) [n:127.0.0.1:36287_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@360fed4a commitCommandVersion:0 [junit4] 2> 796509 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer. [junit4] 2> 796711 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 7 /solr/aliases.json [junit4] 2> 7 /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> 17 /solr/collections/.system/state.json [junit4] 2> 7 /solr/clusterstate.json [junit4] 2> 7 /solr/clusterprops.json [junit4] 2> 6 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 24 /solr/overseer/queue [junit4] 2> 18 /solr/collections [junit4] 2> 12 /solr/overseer/collection-queue-work [junit4] 2> 11 /solr/live_nodes [junit4] 2> [junit4] 2> 796712 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:41529 [junit4] 2> 796712 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41529 [junit4] 2> 796712 INFO (SUITE-SystemCollectionCompatTest-seed#[3F06848800D44EF1]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41529 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_3F06848800D44EF1-001 [junit4] 2> Mar 16, 2020 5:55:54 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=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3f15d2b6), locale=dyo-SN, timezone=America/St_Johns [junit4] 2> NOTE: Linux 5.3.0-40-generic amd64/AdoptOpenJDK 12.0.2 (64-bit)/cpus=16,threads=1,free=280171208,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [IndexSchemaTest, TestBlobHandler, TestSimDistribStateManager, TestSolrTestCaseJ4, CategoryRoutedAliasUpdateProcessorTest, TestSolrCloudSnapshots, TestSolrCoreParser, TestSnapshotCloudManager, TestIndexSearcher, StatsComponentTest, QueryElevationComponentTest, TestRetrieveFieldsOptimizer, CustomCollectionTest, TestDeprecatedFilters, PreAnalyzedFieldManagedSchemaCloudTest, TestSweetSpotSimilarityFactory, SolrCoreMetricManagerTest, TestSubQueryTransformerCrossCore, UniqFieldsUpdateProcessorFactoryTest, DeleteInactiveReplicaTest, DistributedSuggestComponentTest, MissingSegmentRecoveryTest, ScriptEngineTest, CdcrRequestHandlerTest, TestHashPartitioner, AddReplicaTest, SolrLogAuditLoggerPluginTest, SolrCoreTest, TestSystemIdResolver, TestSchemalessBufferedUpdates, WordBreakSolrSpellCheckerTest, TestHighlightDedupGrouping, TestStressLucene, FieldAnalysisRequestHandlerTest, TestComplexPhraseQParserPlugin, DocValuesMissingTest, TestCustomStream, IndexSizeTriggerMixedBoundsTest, XmlInterpolationTest, DimensionalRoutedAliasUpdateProcessorTest, TlogReplayBufferedWhileIndexingTest, TestRemoteStreaming, ChaosMonkeyNothingIsSafeTest, TestTermsQParserPlugin, UpdateParamsTest, HttpPartitionWithTlogReplicasTest, JSONWriterTest, TestSegmentSorting, SparseHLLTest, HdfsChaosMonkeyNothingIsSafeTest, IndexBasedSpellCheckerTest, TestDocTermOrds, SolrJmxReporterTest, TestImpersonationWithHadoopAuth, TestUniqueKeyFieldResource, MaxSizeAutoCommitTest, TestRSAKeyPair, AutoAddReplicasPlanActionTest, AnalyticsMergeStrategyTest, ZkFailoverTest, TestReplicationHandlerBackup, TestEmbeddedSolrServerAdminHandler, TestGraphMLResponseWriter, TestNamedUpdateProcessors, LoggingHandlerTest, BitVectorTest, SolrCLIZkUtilsTest, PackageManagerCLITest, TestJsonFacetsStatsParsing, TestAnalyzedSuggestions, TestSearcherReuse, TestCollectionsAPIViaSolrCloudCluster, NodeAddedTriggerTest, MinimalSchemaTest, BooleanFieldTest, DisMaxRequestHandlerTest, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedGrouping, TestSimpleTrackingShardHandler, ProtectedTermFilterFactoryTest, BasicDistributedZkTest, ConnectionManagerTest, DeleteShardTest, DeleteStatusTest, DistribCursorPagingTest, DistribJoinFromCollectionTest, DocValuesNotIndexedTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, FullSolrCloudDistribCmdsTest, LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerTaskQueueTest, RestartWhileUpdatingTest, RollingRestartTest, ShardRoutingTest, SystemCollectionCompatTest] [junit4] Completed [561/905 (1!)] on J1 in 138.87s, 1 test, 1 error <<< FAILURES! [...truncated 53632 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:635: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:508: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:496: Source checkout is modified!!! Offending files: * lucene/licenses/morfologik-ukrainian-search-4.9.1.jar.sha1 * solr/licenses/morfologik-ukrainian-search-4.9.1.jar.sha1 Total time: 43 minutes 20 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Email was triggered for: Failure - Any Sending email for trigger: Failure - Any Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
