Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5667/ Java: 64bit/jdk-13.0.2 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat Error Message: No live SolrServers available to handle this request:[http://127.0.0.1:63374/solr/.system] Stack Trace: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:63374/solr/.system] at __randomizedtesting.SeedInfo.seed([722364028A230711:2D6C7ABEAEBAE67]: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:830) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:63374/solr/.system at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296) ... 43 more Caused by: java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:284) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:310) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:351) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:802) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:937) 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 14669 lines...] [junit4] Suite: org.apache.solr.cloud.SystemCollectionCompatTest [junit4] 2> 1436236 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/server/solr/configsets/_default/conf' [junit4] 2> 1436236 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1436237 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/data-dir-82-001 [junit4] 2> 1436237 WARN (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=25 numCloses=25 [junit4] 2> 1436237 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1436238 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth [junit4] 2> 1436239 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001 [junit4] 2> 1436239 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1436239 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1436239 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1436339 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:63368 [junit4] 2> 1436339 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:63368 [junit4] 2> 1436339 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:63368 [junit4] 2> 1436340 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 63368 [junit4] 2> 1436344 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436349 INFO (zkConnectionManagerCallback-6144-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436349 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436356 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436356 INFO (zkConnectionManagerCallback-6146-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436356 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436361 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436365 INFO (zkConnectionManagerCallback-6148-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436365 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436474 WARN (jetty-launcher-6149-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23 [junit4] 2> 1436474 WARN (jetty-launcher-6149-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23 [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8 [junit4] 2> 1436474 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8 [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@23887fc0{/solr,null,AVAILABLE} [junit4] 2> 1436477 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@45891e85{/solr,null,AVAILABLE} [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2e05828{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:63374} [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.e.j.s.Server Started @1436572ms [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dddac0f{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:63375} [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63374} [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.e.j.s.Server Started @1436572ms [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63375} [junit4] 2> 1436478 ERROR (jetty-launcher-6149-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1436478 ERROR (jetty-launcher-6149-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-16T02:33:27.851541Z [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr [junit4] 2> 1436478 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-16T02:33:27.851611Z [junit4] 2> 1436479 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436479 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436483 INFO (zkConnectionManagerCallback-6151-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436484 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436484 INFO (zkConnectionManagerCallback-6153-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436484 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436485 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1436486 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1436753 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 1436754 WARN (jetty-launcher-6149-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@369b9df4[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436754 WARN (jetty-launcher-6149-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@369b9df4[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436757 WARN (jetty-launcher-6149-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@20c56e5d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436757 WARN (jetty-launcher-6149-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@20c56e5d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436758 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63368/solr [junit4] 2> 1436759 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436763 INFO (zkConnectionManagerCallback-6161-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436763 INFO (jetty-launcher-6149-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436812 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 1436813 WARN (jetty-launcher-6149-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@705a005b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436813 WARN (jetty-launcher-6149-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@705a005b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436815 WARN (jetty-launcher-6149-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4b77659b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436815 WARN (jetty-launcher-6149-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4b77659b[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1436816 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63368/solr [junit4] 2> 1436817 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436820 INFO (zkConnectionManagerCallback-6167-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436820 INFO (jetty-launcher-6149-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436868 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436871 INFO (zkConnectionManagerCallback-6169-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436871 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436969 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1436972 INFO (zkConnectionManagerCallback-6173-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1436972 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1436999 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63375_solr [junit4] 2> 1437001 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.Overseer Overseer (id=72072616667381768-127.0.0.1:63375_solr-n_0000000000) starting [junit4] 2> 1437017 INFO (OverseerStateUpdate-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:63375_solr [junit4] 2> 1437017 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63375_solr [junit4] 2> 1437020 INFO (OverseerStateUpdate-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1437025 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 1437026 WARN (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_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> 1437039 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1437048 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:63374_solr as DOWN [junit4] 2> 1437048 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1437050 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1437050 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63374_solr [junit4] 2> 1437053 INFO (zkCallback-6172-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1437053 INFO (zkCallback-6168-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 1437056 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1 [junit4] 2> 1437056 WARN (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_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> 1437074 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63375.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437077 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1437082 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63375.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437082 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63375.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437084 INFO (jetty-launcher-6149-thread-1) [n:127.0.0.1:63375_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node1/. [junit4] 2> 1437107 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437115 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437115 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437117 INFO (jetty-launcher-6149-thread-2) [n:127.0.0.1:63374_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/. [junit4] 2> 1437227 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2 [junit4] 2> 1437228 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1437231 INFO (zkConnectionManagerCallback-6184-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1437231 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1437234 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 1437238 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63368/solr ready [junit4] 2> 1437269 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackCompat [junit4] 2> 1437271 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1437274 INFO (zkConnectionManagerCallback-6189-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1437274 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1437277 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 1437282 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63368/solr ready [junit4] 2> 1437284 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1437297 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=13 [junit4] 2> 1437300 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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:63374_solr&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1437343 INFO (OverseerThreadFactory-5126-thread-2-processing-n:127.0.0.1:63375_solr) [n:127.0.0.1:63375_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system [junit4] 2> 1437345 INFO (OverseerCollectionConfigSetProcessor-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_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> 1437493 WARN (OverseerThreadFactory-5126-thread-2-processing-n:127.0.0.1:63375_solr) [n:127.0.0.1:63375_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> 1437504 INFO (OverseerStateUpdate-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:63374/solr";, [junit4] 2> "node_name":"127.0.0.1:63374_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 1437518 INFO (OverseerStateUpdate-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":".system", [junit4] 2> "shard":"shard1", [junit4] 2> "core":".system_shard1_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:63374/solr";, [junit4] 2> "node_name":"127.0.0.1:63374_solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 1437726 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437726 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437751 WARN (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version. [junit4] 2> 1437751 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437752 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437756 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437757 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437760 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 1437760 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 1437770 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437770 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437773 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437773 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437776 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437777 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437778 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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 [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/.system_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/./.system_shard1_replica_n1/data/] [junit4] 2> 1437785 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437785 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437786 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.core..system.shard1.replica_n2' (registry 'solr.core..system.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1437786 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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 [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/.system_shard1_replica_n2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/./.system_shard1_replica_n2/data/] [junit4] 2> 1437897 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437897 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437899 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437899 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1437904 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2c9be361[.system_shard1_replica_n2] main] [junit4] 2> 1437911 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437911 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437913 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437918 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437918 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437920 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437920 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437920 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1437921 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2bb9d78c[.system_shard1_replica_n1] main] [junit4] 2> 1437922 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.IndexSchema [.system_shard1_replica_n2] Schema name=_system collection or core [junit4] 2> 1437925 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437925 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437925 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 5 ms [junit4] 2> 1437926 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437926 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437926 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437926 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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 1658658917501108224 [junit4] 2> 1437928 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437929 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437929 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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 1658658917504253952 [junit4] 2> 1437933 INFO (searcherExecutor-5135-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_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@2bb9d78c[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1437933 INFO (searcherExecutor-5136-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:63374_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@2c9be361[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1437941 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437942 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1437943 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437944 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1437979 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 1437980 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 1437980 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ [junit4] 2> 1437982 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:63374/solr START replicas=[http://127.0.0.1:63374/solr/.system_shard1_replica_n1/] nUpdates=100 [junit4] 2> 1437983 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.PeerSync PeerSync: core=.system_shard1_replica_n2 url=http://127.0.0.1:63374/solr DONE. We have no versions. sync failed. [junit4] 2> 1437993 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request [.system_shard1_replica_n1] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1437993 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate [junit4] 2> 1437994 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway [junit4] 2> 1437994 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72072616667381767-core_node4-n_0000000000 [junit4] 2> 1438025 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ shard1 [junit4] 2> 1438132 INFO (zkCallback-6168-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> 1438132 INFO (zkCallback-6168-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> 1438135 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 1438184 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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=459 [junit4] 2> 1438273 INFO (zkCallback-6168-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> 1438273 INFO (zkCallback-6168-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> 1438273 INFO (zkCallback-6168-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> 1438979 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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=1254 [junit4] 2> 1438988 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439086 INFO (zkCallback-6168-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> 1439087 INFO (zkCallback-6168-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> 1439087 INFO (zkCallback-6168-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> 1439089 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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:63374_solr&wt=javabin&version=2} status=0 QTime=1789 [junit4] 2> 1439089 INFO (TEST-SystemCollectionCompatTest.testBackCompat-seed#[722364028A230711]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system [junit4] 2> 1439105 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node3=1, core_node4=1}, version=2} [junit4] 2> 1439109 INFO (qtp203929564-16698) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:63374/solr/.system_shard1_replica_n2/&wt=javabin&version=2}{add=[1704bd7fa63Tac7s5qrtksp4wkjfltn4otqeo (1658658918731087872)]} 0 2 [junit4] 2> 1439110 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1704bd7fa63Tac7s5qrtksp4wkjfltn4otqeo (1658658918731087872)]} 0 13 [junit4] 2> 1439111 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1658658918743670784,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1439112 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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@c653ed8 commitCommandVersion:1658658918743670784 [junit4] 2> 1439113 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1658658918745767936,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1439113 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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@2adf8858 commitCommandVersion:1658658918745767936 [junit4] 2> 1439122 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@657d2146[.system_shard1_replica_n1] main] [junit4] 2> 1439122 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a1f2d68[.system_shard1_replica_n2] main] [junit4] 2> 1439122 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1439122 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1439123 INFO (searcherExecutor-5135-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_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@657d2146[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.vm.version=13.0.2+8, java.version=13.0.2, timestamp=1581820410490, java.vendor=AdoptOpenJDK, os=Mac OS X, os.version=10.14.6, java.runtime.version=13.0.2+8, os.arch=x86_64, source=flush, lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 1439125 INFO (searcherExecutor-5136-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n2 c:.system s:shard1 r:core_node4) [n:127.0.0.1:63374_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@3a1f2d68[.system_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.vm.version=13.0.2+8, java.version=13.0.2, timestamp=1581820410489, java.vendor=AdoptOpenJDK, os=Mac OS X, os.version=10.14.6, java.runtime.version=13.0.2+8, os.arch=x86_64, source=flush, lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 1439127 INFO (qtp203929564-16697) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:63374/solr/.system_shard1_replica_n2/&commit_end_point=replicas&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 14 [junit4] 2> 1439128 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n2 ] o.a.s.u.p.LogUpdateProcessorFactory [.system_shard1_replica_n2] webapp=/solr path=/update params={_stateVer_=.system:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 16 [junit4] 2> 1439132 INFO (qtp203929564-16698) [n:127.0.0.1:63374_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 1439136 INFO (qtp203929564-16695) [n:127.0.0.1:63374_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 1439137 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439147 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439149 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 1439151 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439154 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439156 INFO (Thread-2216) [ ] o.a.s.c.SolrCore config update listener called for core .system_shard1_replica_n1 [junit4] 2> 1439164 INFO (Thread-2216) [ ] o.a.s.c.SolrCore core reload .system_shard1_replica_n1 [junit4] 2> 1439184 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439212 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 1439221 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439221 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439275 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63374.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@362b829b [junit4] 2> 1439275 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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 [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/.system_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001/tempDir-001/node2/./.system_shard1_replica_n1/data/] [junit4] 2> 1439359 INFO (OverseerCollectionConfigSetProcessor-72072616667381768-127.0.0.1:63375_solr-n_0000000000) [n:127.0.0.1:63375_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 1439463 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439463 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1439469 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e947f01[.system_shard1_replica_n1] main] [junit4] 2> 1439474 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439475 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439475 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439478 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439479 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439483 INFO (searcherExecutor-5145-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_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@5e947f01[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.vm.version=13.0.2+8, java.version=13.0.2, timestamp=1581820410490, java.vendor=AdoptOpenJDK, os=Mac OS X, os.version=10.14.6, java.runtime.version=13.0.2+8, os.arch=x86_64, source=flush, lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 1439486 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439488 INFO (qtp203929564-16693) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1482f96[.system_shard1_replica_n1] main] [junit4] 2> 1439488 INFO (qtp203929564-16693) [n:127.0.0.1:63374_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> 1439490 INFO (searcherExecutor-5145-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_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@1482f96[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={java.vm.version=13.0.2+8, java.version=13.0.2, timestamp=1581820410490, os=Mac OS X, java.vendor=AdoptOpenJDK, os.version=10.14.6, java.runtime.version=13.0.2+8, os.arch=x86_64, source=flush, lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 1439496 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439499 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439499 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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=3 [junit4] 2> 1439501 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439504 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439505 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439505 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439506 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439507 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439509 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439509 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439509 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439511 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439513 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439513 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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=2 [junit4] 2> 1439514 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439515 INFO (Thread-2216) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 1439515 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439516 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439516 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439517 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439519 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439520 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439520 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439521 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439522 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439523 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439523 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439524 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439525 INFO (Thread-2216) [ ] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core [junit4] 2> 1439526 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439527 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439527 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439527 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439528 INFO (Thread-2216) [ ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id [junit4] 2> 1439529 INFO (Thread-2216) [ ] o.a.s.c.CoreContainer Reloading SolrCore '.system_shard1_replica_n1' using configuration from configset .system [junit4] 2> 1439529 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439530 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439530 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439530 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439532 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439533 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439533 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439533 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439535 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439536 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439536 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439536 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439537 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439539 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439539 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439539 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439541 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439542 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439542 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439542 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439544 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439545 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439545 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439546 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439547 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439548 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439548 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439549 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439551 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439553 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439553 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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=2 [junit4] 2> 1439554 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439556 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439558 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439558 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439558 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439560 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439561 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439561 INFO (qtp203929564-16698) [n:127.0.0.1:63374_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> 1439561 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439563 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439564 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439564 INFO (qtp203929564-16695) [n:127.0.0.1:63374_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> 1439564 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied schema version 2 [junit4] 2> 1439566 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439567 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439567 INFO (qtp203929564-16697) [n:127.0.0.1:63374_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> 1439567 ERROR (managedSchemaExecutor-5149-thread-1-processing-n:127.0.0.1:63374_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:63374_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Replica http://127.0.0.1:63374/solr/.system_shard1_replica_n2/ returned schema version 0 and has not applied s [...truncated too long message...] tem s:shard1 r:core_node2) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:49980/solr/.system_shard1_replica_n3/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:49980/solr/.system_shard1_replica_n3 [junit4] 2> 157598 WARN (managedSchemaExecutor-37-thread-1-processing-n:127.0.0.1:49980_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:49980/solr/.system_shard1_replica_n3/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:49980/solr/.system_shard1_replica_n3 [junit4] 2> 157602 WARN (managedSchemaExecutor-37-thread-1-processing-n:127.0.0.1:49980_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:49980/solr/.system_shard1_replica_n3/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:49980/solr/.system_shard1_replica_n3 [junit4] 2> 157603 WARN (managedSchemaExecutor-37-thread-1-processing-n:127.0.0.1:49980_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to get /schema/zkversion from http://127.0.0.1:49980/solr/.system_shard1_replica_n3/ due to: java.util.concurrent.ExecutionException: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:49980/solr/.system_shard1_replica_n3 [junit4] 2> 157746 INFO (httpUriRequest-73371-thread-1-processing-x:.system_shard1_replica_n1 r:core_node2 n:127.0.0.1:49980_solr http:////127.0.0.1:49980//solr//.system_shard1_replica_n3 c:.system s:shard1) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:49980: Socket closed [junit4] 2> 157746 INFO (httpUriRequest-73371-thread-1-processing-x:.system_shard1_replica_n1 r:core_node2 n:127.0.0.1:49980_solr http:////127.0.0.1:49980//solr//.system_shard1_replica_n3 c:.system s:shard1) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec Retrying request to {}->http://127.0.0.1:49980 [junit4] 2> 157748 WARN (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Core core_node2 was interrupted waiting for schema version 2 to propagate to 1 replicas for collection .system [junit4] 2> 157748 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Took 134595.0ms for 1 replicas to apply schema update version 2 for collection .system [junit4] 2> 157748 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 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=135937 [junit4] 2> 157748 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@be6fe47 [junit4] 2> 157748 WARN (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 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> 157748 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection..system.shard1.leader, tag=SolrCore@be6fe47 [junit4] 2> 157749 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() . [junit4] 2> 157750 INFO (qtp830227815-56) [n:127.0.0.1:49980_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@7b976990 commitCommandVersion:0 [junit4] 2> 157772 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer. [junit4] 2> 158018 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 7 /solr/clusterprops.json [junit4] 2> 7 /solr/aliases.json [junit4] 2> 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> 16 /solr/collections/.system/state.json [junit4] 2> 7 /solr/clusterstate.json [junit4] 2> 6 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 25 /solr/overseer/queue [junit4] 2> 18 /solr/collections [junit4] 2> 13 /solr/overseer/collection-queue-work [junit4] 2> 12 /solr/live_nodes [junit4] 2> [junit4] 2> 158027 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:49957 [junit4] 2> 158027 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:49957 [junit4] 2> 158027 INFO (SUITE-SystemCollectionCompatTest-seed#[722364028A230711]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 49957 [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.SystemCollectionCompatTest_722364028A230711-001 [junit4] 2> Feb 16, 2020 3:21:10 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), type=PostingsFormat(name=Asserting)}, docValues:{timestamp_l=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Asserting), time_l=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1141, maxMBSortInHeap=6.207007136064755, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4a7426f8), locale=or, timezone=Etc/GMT-11 [junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 13.0.2 (64-bit)/cpus=6,threads=2,free=100728984,total=171966464 [junit4] 2> NOTE: All tests run in this JVM: [SystemCollectionCompatTest] [junit4] Completed [5/5 (1!)] on J0 in 157.14s, 1 test, 1 error <<< FAILURES! [...truncated 13 lines...] BUILD FAILED /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1518: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1045: There were test failures: 5 suites, 5 tests, 1 error [seed: 722364028A230711] Total time: 3 minutes 12 seconds [repro] Setting last failure code to 256 [repro] Failures w/original seeds: [repro] 1/5 failed: org.apache.solr.cloud.SystemCollectionCompatTest [repro] Exiting with code 256 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 No credentials specified Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=188f620208012ba1d726b743c5934abf01988d57, workspace=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX [WARNINGS] Computing warning deltas based on reference build #5666 Recording test results Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
