Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23950/ Java: 64bit/jdk-11 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateCollWithDefaultClusterPropertiesOldFormat Error Message: expected:<[2]> but was:<[null]> Stack Trace: org.junit.ComparisonFailure: expected:<[2]> but was:<[null]> at __randomizedtesting.SeedInfo.seed([CFF2DFB82A0DB7A2:A521F05D5E669B1D]:0) at org.junit.Assert.assertEquals(Assert.java:115) at org.junit.Assert.assertEquals(Assert.java:144) at org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateCollWithDefaultClusterPropertiesOldFormat(CollectionsAPISolrJTest.java:153) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) 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:368) at java.base/java.lang.Thread.run(Thread.java:834) Build Log: [...truncated 13716 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/init-core-data-001 [junit4] 2> 962140 WARN (SUITE-CollectionsAPISolrJTest-seed#[CFF2DFB82A0DB7A2]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=30 numCloses=30 [junit4] 2> 962140 INFO (SUITE-CollectionsAPISolrJTest-seed#[CFF2DFB82A0DB7A2]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 962140 INFO (SUITE-CollectionsAPISolrJTest-seed#[CFF2DFB82A0DB7A2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 962140 INFO (SUITE-CollectionsAPISolrJTest-seed#[CFF2DFB82A0DB7A2]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 962142 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRenameCollection [junit4] 2> 962142 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001 [junit4] 2> 962142 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 962143 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 962143 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 962243 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.ZkTestServer start zk server on port:41803 [junit4] 2> 962243 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41803 [junit4] 2> 962243 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41803 [junit4] 2> 962246 INFO (zkConnectionManagerCallback-13066-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962248 INFO (zkConnectionManagerCallback-13068-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962249 INFO (zkConnectionManagerCallback-13070-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962250 WARN (jetty-launcher-13071-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 962250 WARN (jetty-launcher-13071-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 962250 WARN (jetty-launcher-13071-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 962250 WARN (jetty-launcher-13071-thread-4) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 962251 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11+28 [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 962252 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@427d8ed2{/solr,null,AVAILABLE} [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@27d2bde2{/solr,null,AVAILABLE} [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6487e951{/solr,null,AVAILABLE} [junit4] 2> 962253 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@73f30b8d{/solr,null,AVAILABLE} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5a54ce17{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:44183} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6660c97c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43581} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@8fd29a7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35943} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1519a6db{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35037} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.e.j.s.Server Started @962338ms [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.e.j.s.Server Started @962338ms [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.e.j.s.Server Started @962338ms [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43581} [junit4] 2> 962254 ERROR (jetty-launcher-13071-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-19T22:23:50.870552Z [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.e.j.s.Server Started @962339ms [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44183} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35943} [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=35037} [junit4] 2> 962254 ERROR (jetty-launcher-13071-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 962254 ERROR (jetty-launcher-13071-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 962254 ERROR (jetty-launcher-13071-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0 [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-19T22:23:50.870958Z [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-19T22:23:50.870979Z [junit4] 2> 962254 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-04-19T22:23:50.870979Z [junit4] 2> 962255 INFO (zkConnectionManagerCallback-13073-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962255 INFO (zkConnectionManagerCallback-13075-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962255 INFO (zkConnectionManagerCallback-13078-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962255 INFO (zkConnectionManagerCallback-13079-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962255 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 962255 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 962256 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 962258 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 962258 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1003028954c0004, likely client has closed socket [junit4] 2> 962286 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 962287 WARN (jetty-launcher-13071-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@146f5016[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962289 WARN (jetty-launcher-13071-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@13c25d98[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962290 INFO (jetty-launcher-13071-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41803/solr [junit4] 2> 962291 INFO (zkConnectionManagerCallback-13089-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962297 INFO (zkConnectionManagerCallback-13091-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962305 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 962307 WARN (jetty-launcher-13071-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@440e4101[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962309 WARN (jetty-launcher-13071-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2cc6cb6d[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962310 INFO (jetty-launcher-13071-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41803/solr [junit4] 2> 962311 INFO (zkConnectionManagerCallback-13099-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962312 INFO (zkConnectionManagerCallback-13101-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962316 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 962316 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43581_solr [junit4] 2> 962316 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.c.Overseer Overseer (id=72110544899538954-127.0.0.1:43581_solr-n_0000000000) starting [junit4] 2> 962316 WARN (jetty-launcher-13071-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@70b3da84[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962320 INFO (zkConnectionManagerCallback-13110-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962320 WARN (jetty-launcher-13071-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@ee4d2a7[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962321 INFO (jetty-launcher-13071-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41803/solr [junit4] 2> 962321 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41803/solr ready [junit4] 2> 962322 INFO (OverseerStateUpdate-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43581_solr [junit4] 2> 962322 INFO (zkConnectionManagerCallback-13114-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962322 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43581_solr [junit4] 2> 962323 INFO (zkCallback-13100-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 962324 INFO (zkCallback-13109-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 962327 INFO (zkConnectionManagerCallback-13116-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962329 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 962331 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 962331 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:35037_solr as DOWN [junit4] 2> 962332 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 962332 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35037_solr [junit4] 2> 962332 INFO (zkCallback-13100-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 962332 INFO (zkCallback-13109-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 962333 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:44183_solr as DOWN [junit4] 2> 962333 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 962333 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44183_solr [junit4] 2> 962333 INFO (zkCallback-13100-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 962333 INFO (zkCallback-13109-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 962343 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 962343 INFO (zkCallback-13115-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 962347 INFO (zkCallback-13090-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 962355 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43581.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962363 INFO (zkConnectionManagerCallback-13124-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962363 INFO (zkConnectionManagerCallback-13129-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962368 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 962368 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41803/solr ready [junit4] 2> 962369 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43581.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962369 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43581.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962369 INFO (jetty-launcher-13071-thread-4) [n:127.0.0.1:43581_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node4/. [junit4] 2> 962376 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 962376 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41803/solr ready [junit4] 2> 962381 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 962387 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 962400 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35037.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962403 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44183.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962406 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35037.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962406 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35037.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962407 INFO (jetty-launcher-13071-thread-2) [n:127.0.0.1:35037_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node2/. [junit4] 2> 962411 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44183.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962411 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44183.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962412 INFO (jetty-launcher-13071-thread-1) [n:127.0.0.1:44183_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node1/. [junit4] 2> 962432 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 962432 WARN (jetty-launcher-13071-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@18466694[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962437 WARN (jetty-launcher-13071-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@74a5101e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 962437 INFO (jetty-launcher-13071-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41803/solr [junit4] 2> 962439 INFO (zkConnectionManagerCallback-13137-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962443 INFO (zkConnectionManagerCallback-13139-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962445 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 962446 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:35943_solr as DOWN [junit4] 2> 962446 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 962446 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35943_solr [junit4] 2> 962447 INFO (zkCallback-13115-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962447 INFO (zkCallback-13109-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962447 INFO (zkCallback-13100-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962447 INFO (zkCallback-13090-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962447 INFO (zkCallback-13123-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962447 INFO (zkCallback-13128-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962448 INFO (zkCallback-13138-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 962455 INFO (zkConnectionManagerCallback-13146-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962456 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 962457 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41803/solr ready [junit4] 2> 962459 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 962470 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35943.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962476 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35943.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962476 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35943.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 962476 INFO (jetty-launcher-13071-thread-3) [n:127.0.0.1:35943_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node3/. [junit4] 2> 962504 INFO (zkConnectionManagerCallback-13152-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 962506 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 962506 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41803/solr ready [junit4] 2> 962511 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 962512 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 962513 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=testRename_collection1&nrtReplicas=1&action=CREATE&numShards=1&alias=col1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 962514 INFO (OverseerThreadFactory-7364-thread-1-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testRename_collection1 [junit4] 2> 962617 INFO (OverseerStateUpdate-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testRename_collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testRename_collection1_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:35943/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 962820 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr x:testRename_collection1_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testRename_collection1_shard1_replica_n1&action=CREATE&numShards=1&collection=testRename_collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 963825 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 963829 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.s.IndexSchema [testRename_collection1_shard1_replica_n1] Schema name=minimal [junit4] 2> 963830 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 963830 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testRename_collection1_shard1_replica_n1' using configuration from collection testRename_collection1, trusted=true [junit4] 2> 963830 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35943.solr.core.testRename_collection1.shard1.replica_n1' (registry 'solr.core.testRename_collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 963831 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SolrCore [[testRename_collection1_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node3/testRename_collection1_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node3/./testRename_collection1_shard1_replica_n1/data/] [junit4] 2> 963857 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 963857 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 963859 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 963859 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 963860 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@49015836[testRename_collection1_shard1_replica_n1] main] [junit4] 2> 963860 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 963861 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 963861 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 963861 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1631282929312202752 [junit4] 2> 963863 INFO (searcherExecutor-7384-thread-1-processing-n:127.0.0.1:35943_solr x:testRename_collection1_shard1_replica_n1 c:testRename_collection1 s:shard1 r:core_node2) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SolrCore [testRename_collection1_shard1_replica_n1] Registered new searcher Searcher@49015836[testRename_collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 963865 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testRename_collection1/terms/shard1 to Terms{values={core_node2=0}, version=0} [junit4] 2> 963865 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testRename_collection1/leaders/shard1 [junit4] 2> 963866 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 963866 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 963866 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35943/solr/testRename_collection1_shard1_replica_n1/ [junit4] 2> 963867 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 963867 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:35943/solr/testRename_collection1_shard1_replica_n1/ has no replicas [junit4] 2> 963867 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testRename_collection1/leaders/shard1/leader after winning as /collections/testRename_collection1/leader_elect/shard1/election/72110544899538961-core_node2-n_0000000000 [junit4] 2> 963869 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35943/solr/testRename_collection1_shard1_replica_n1/ shard1 [junit4] 2> 963970 INFO (zkCallback-13138-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection1/state.json] for collection [testRename_collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 963970 INFO (zkCallback-13138-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection1/state.json] for collection [testRename_collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 963970 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 964071 INFO (zkCallback-13138-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection1/state.json] for collection [testRename_collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 964071 INFO (zkCallback-13138-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection1/state.json] for collection [testRename_collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 964071 INFO (zkCallback-13138-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection1/state.json] for collection [testRename_collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 964086 INFO (qtp1329035750-28953) [n:127.0.0.1:35943_solr c:testRename_collection1 s:shard1 r:core_node2 x:testRename_collection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testRename_collection1_shard1_replica_n1&action=CREATE&numShards=1&collection=testRename_collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1266 [junit4] 2> 964089 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_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> 964092 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=testRename_collection1&nrtReplicas=1&action=CREATE&numShards=1&alias=col1&wt=javabin&version=2} status=0 QTime=1579 [junit4] 2> 964092 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=testRename_collection2&nrtReplicas=1&action=CREATE&numShards=1&alias=col2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 964094 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_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> 964094 INFO (OverseerThreadFactory-7364-thread-2-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testRename_collection2 [junit4] 2> 964298 INFO (OverseerStateUpdate-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testRename_collection2", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testRename_collection2_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:35037/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 964500 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr x:testRename_collection2_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testRename_collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=testRename_collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 965505 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 965510 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.s.IndexSchema [testRename_collection2_shard1_replica_n1] Schema name=minimal [junit4] 2> 965511 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 965511 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testRename_collection2_shard1_replica_n1' using configuration from collection testRename_collection2, trusted=true [junit4] 2> 965511 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_35037.solr.core.testRename_collection2.shard1.replica_n1' (registry 'solr.core.testRename_collection2.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 965512 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SolrCore [[testRename_collection2_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node2/testRename_collection2_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node2/./testRename_collection2_shard1_replica_n1/data/] [junit4] 2> 965555 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 965555 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 965557 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 965557 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 965559 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d5e4cc2[testRename_collection2_shard1_replica_n1] main] [junit4] 2> 965559 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 965560 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 965560 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 965560 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1631282931093733376 [junit4] 2> 965562 INFO (searcherExecutor-7389-thread-1-processing-n:127.0.0.1:35037_solr x:testRename_collection2_shard1_replica_n1 c:testRename_collection2 s:shard1 r:core_node2) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SolrCore [testRename_collection2_shard1_replica_n1] Registered new searcher Searcher@6d5e4cc2[testRename_collection2_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 965564 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testRename_collection2/terms/shard1 to Terms{values={core_node2=0}, version=0} [junit4] 2> 965565 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testRename_collection2/leaders/shard1 [junit4] 2> 965568 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 965568 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 965568 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35037/solr/testRename_collection2_shard1_replica_n1/ [junit4] 2> 965568 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 965569 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:35037/solr/testRename_collection2_shard1_replica_n1/ has no replicas [junit4] 2> 965569 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testRename_collection2/leaders/shard1/leader after winning as /collections/testRename_collection2/leader_elect/shard1/election/72110544899538957-core_node2-n_0000000000 [junit4] 2> 965570 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35037/solr/testRename_collection2_shard1_replica_n1/ shard1 [junit4] 2> 965671 INFO (zkCallback-13115-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection2/state.json] for collection [testRename_collection2] has occurred - updating... (live nodes size: [4]) [junit4] 2> 965671 INFO (zkCallback-13115-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection2/state.json] for collection [testRename_collection2] has occurred - updating... (live nodes size: [4]) [junit4] 2> 965671 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 965672 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr c:testRename_collection2 s:shard1 r:core_node2 x:testRename_collection2_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testRename_collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=testRename_collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1172 [junit4] 2> 965673 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_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> 965773 INFO (zkCallback-13115-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection2/state.json] for collection [testRename_collection2] has occurred - updating... (live nodes size: [4]) [junit4] 2> 965773 INFO (zkCallback-13115-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection2/state.json] for collection [testRename_collection2] has occurred - updating... (live nodes size: [4]) [junit4] 2> 965773 INFO (zkCallback-13115-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testRename_collection2/state.json] for collection [testRename_collection2] has occurred - updating... (live nodes size: [4]) [junit4] 2> 965773 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=testRename_collection2&nrtReplicas=1&action=CREATE&numShards=1&alias=col2&wt=javabin&version=2} status=0 QTime=1680 [junit4] 2> 965774 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica count: 1 [junit4] 2> 965774 INFO (watches-13149-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica count: 1 [junit4] 2> 965774 INFO (TEST-CollectionsAPISolrJTest.testRenameCollection-seed#[CFF2DFB82A0DB7A2]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica count: 1 [junit4] 2> 965774 INFO (watches-13149-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica count: 1 [junit4] 2> 965775 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params collections=col1,col2&name=compoundAlias&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 965777 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_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> 965880 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collections=col1,col2&name=compoundAlias&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=104 [junit4] 2> 965880 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params collections=col1&name=simpleAlias&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 965881 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 965983 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collections=col1&name=simpleAlias&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=102 [junit4] 2> 965984 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params router.maxCardinality=100&create-collection.collection.configName=conf&router.field=field1&name=catAlias&router.name=category&create-collection.numShards=1&create-collection.nrtReplicas=1&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 965988 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 965989 INFO (OverseerThreadFactory-7364-thread-5-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP [junit4] 2> 966194 INFO (OverseerStateUpdate-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:44183/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 966395 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&collection=catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP&version=2&replicaType=NRT&property.routedAliasName=catAlias&coreNodeName=core_node2&name=catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin [junit4] 2> 967416 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 967421 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.s.IndexSchema [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] Schema name=minimal [junit4] 2> 967422 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 967422 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1' using configuration from collection catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP, trusted=true [junit4] 2> 967422 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44183.solr.core.catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP.shard1.replica_n1' (registry 'solr.core.catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2707b35e [junit4] 2> 967422 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SolrCore [[catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node1/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionsAPISolrJTest_CFF2DFB82A0DB7A2-001/tempDir-001/node1/./catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1/data/] [junit4] 2> 967452 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 967452 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 967468 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 967468 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 967469 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ddbd4a1[catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] main] [junit4] 2> 967470 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 967470 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 967470 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 967470 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1631282933096513536 [junit4] 2> 967473 INFO (searcherExecutor-7394-thread-1-processing-n:127.0.0.1:44183_solr x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1 c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SolrCore [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] Registered new searcher Searcher@4ddbd4a1[catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 967474 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/terms/shard1 to Terms{values={core_node2=0}, version=0} [junit4] 2> 967474 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/leaders/shard1 [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:44183/solr/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1/ [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:44183/solr/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1/ has no replicas [junit4] 2> 967475 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/leaders/shard1/leader after winning as /collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/leader_elect/shard1/election/72110544899538952-core_node2-n_0000000000 [junit4] 2> 967476 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:44183/solr/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1/ shard1 [junit4] 2> 967577 INFO (zkCallback-13090-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967578 INFO (zkCallback-13090-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967578 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 967579 INFO (qtp1018621436-28962) [n:127.0.0.1:44183_solr c:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP s:shard1 r:core_node2 x:catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP&version=2&replicaType=NRT&property.routedAliasName=catAlias&coreNodeName=core_node2&name=catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin} status=0 QTime=1183 [junit4] 2> 967579 INFO (OverseerThreadFactory-7364-thread-5-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_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> 967679 INFO (zkCallback-13100-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967679 INFO (zkCallback-13090-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967679 INFO (zkCallback-13090-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967679 INFO (zkCallback-13090-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json] for collection [catAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP] has occurred - updating... (live nodes size: [4]) [junit4] 2> 967781 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={router.maxCardinality=100&create-collection.collection.configName=conf&router.field=field1&name=catAlias&router.name=category&create-collection.numShards=1&create-collection.nrtReplicas=1&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=1796 [junit4] 2> 967782 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :rename with params name=col1&action=RENAME&wt=javabin&version=2&target=foo and sendToOCPQueue=true [junit4] 2> 967784 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000008 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 967785 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=col1&action=RENAME&wt=javabin&version=2&target=foo} status=0 QTime=2 [junit4] 2> 967786 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :rename with params name=testRename_collection1&action=RENAME&wt=javabin&version=2&target=testRename_collection2 and sendToOCPQueue=true [junit4] 2> 967787 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000010 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 967788 INFO (qtp2080951088-28952) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testRename_collection1&action=RENAME&wt=javabin&version=2&target=testRename_collection2} status=0 QTime=2 [junit4] 2> 967789 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :rename with params name=catAlias&action=RENAME&wt=javabin&version=2&target=bar and sendToOCPQueue=true [junit4] 2> 967790 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000012 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 967790 ERROR (OverseerThreadFactory-7364-thread-5-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: catAlias operation: rename failed:java.lang.IllegalArgumentException: source name 'catAlias' is a routed alias. [junit4] 2> at org.apache.solr.common.cloud.Aliases.cloneWithRename(Aliases.java:336) [junit4] 2> at org.apache.solr.cloud.api.collections.RenameCmd.lambda$call$0(RenameCmd.java:67) [junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$AliasesManager.applyModificationAndExportToZk(ZkStateReader.java:1830) [junit4] 2> at org.apache.solr.cloud.api.collections.RenameCmd.call(RenameCmd.java:67) [junit4] 2> at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:264) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:505) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:834) [junit4] 2> [junit4] 2> 967795 INFO (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=catAlias&action=RENAME&wt=javabin&version=2&target=bar} status=500 QTime=6 [junit4] 2> 967796 ERROR (qtp2080951088-28946) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: source name 'catAlias' is a routed alias. [junit4] 2> at org.apache.solr.client.solrj.SolrResponse.getException(SolrResponse.java:53) [junit4] 2> at org.apache.solr.handler.admin.CollectionsHandler.invokeAction(CollectionsHandler.java:279) [junit4] 2> at org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:251) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:796) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:762) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:522) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:397) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:343) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:753) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:502) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:305) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) [junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:834) [junit4] 2> [junit4] 2> 967796 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :rename with params name=col2&action=RENAME&wt=javabin&version=2&target=foo and sendToOCPQueue=true [junit4] 2> 967797 INFO (OverseerCollectionConfigSetProcessor-72110544899538954-127.0.0.1:43581_solr-n_0000000000) [n:127.0.0.1:43581_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000014 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 967797 ERROR (OverseerThreadFactory-7364-thread-5-processing-n:127.0.0.1:43581_solr) [n:127.0.0.1:43581_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: col2 operation: rename failed:org.apache.solr.common.SolrException: target alias 'foo' exists: [testRename_collection2] [junit4] 2> at org.apache.solr.cloud.api.collections.RenameCmd.call(RenameCmd.java:64) [junit4] 2> at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:264) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:505) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:834) [junit4] 2> [junit4] 2> 967800 INFO (qtp2080951088-28950) [n:127.0.0.1:35037_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=col2&action=RENAME&wt=javabin&version=2&target=foo} status=400 QTime=3 [junit4] 2> 967801 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2138771861 [junit4] 2> 967801 INFO (jetty-closer-13156-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1778762833 [junit4] 2> 967801 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43581_solr [junit4] 2> 967801 INFO (jetty-closer-13156-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:35037_solr [junit4] 2> 967801 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.c.ZkController Publish this node as DOWN... [junit4] 2> 967801 INFO (jetty-closer-13156-thread-2) [ ] o.a.s.c.ZkController Publish this node as DOWN... [junit4] 2> 967801 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:43581_solr as DOWN [junit4] 2> 967801 INFO (jetty-closer-13156-thread-2) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:35037_solr as DOWN [junit4] 2> 967803 INFO (jetty-closer-13156-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1890230949 [junit4] 2> 967803 INFO (jetty-closer-13156-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:44183_solr [junit4] 2> 967803 INFO (jetty-closer-13156-thread-3) [ ] o.a.s.c.ZkController Publish this node as DOWN... [junit4] 2> 967803 INFO (jetty-closer-13156-thread-3) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:44183_solr as DOWN [junit4] 2> 967815 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 967825 INFO (jetty-closer-13156-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1324642544 [junit4] 2> 967825 INFO (jetty-closer-13156-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:35943_solr [junit4] 2> 967825 INFO (jetty-closer-13156-thread-4) [ ] o.a.s.c.ZkController Publish this node as DOWN... [junit4] 2> 967825 INFO (jetty-closer-13156-thread-4) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:35943_solr as DOWN [junit4] 2> 967835 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 967835 INFO (jetty-closer-13156-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@15eaf099: rootName = solr_43581, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@192a4319 [...truncated too long message...] :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/null1995104312 [copy] Copying 38 files to /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/null1995104312 [delete] Deleting directory /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/null1995104312 resolve-example: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: resolve-server: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/null443416197 [copy] Copying 239 files to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/null443416197 [delete] Deleting directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/null443416197 check-working-copy: [ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working [ivy:cachepath] confs: [default] [ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public [ivy:cachepath] found com.jcraft#jsch;0.1.53 in public [ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public [ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public [ivy:cachepath] found commons-codec#commons-codec;1.6 in public [ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public [ivy:cachepath] :: resolution report :: resolve 336ms :: artifacts dl 0ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 8 | 0 | 0 | 0 || 8 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". [wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation [wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. [wc-checker] Checking working copy status... BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:633: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:506: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:493: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files: * solr/licenses/gmetric4j-1.0.7.jar.sha1 Total time: 89 minutes 26 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Email was triggered for: Failure - Any Sending email for trigger: Failure - Any Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org