Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23955/
Java: 64bit/jdk-11.0.2 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.AliasIntegrationTest.testClusterStateProviderAPI
Error Message:
should be a routed alias
Stack Trace:
java.lang.AssertionError: should be a routed alias
at
__randomizedtesting.SeedInfo.seed([BE8815431FC643A2:A15F896F6CCDBAE9]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.cloud.AliasIntegrationTest.testClusterStateProviderAPI(AliasIntegrationTest.java:302)
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)
FAILED:
org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest.testSliceRouting
Error Message:
Timeout occurred while waiting response from server at:
http://127.0.0.1:38623/solr/myAlias__CRA__Heart_of_Gold_shard3_replica_n13
Stack Trace:
org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Timeout
occurred while waiting response from server at:
http://127.0.0.1:38623/solr/myAlias__CRA__Heart_of_Gold_shard3_replica_n13
at
__randomizedtesting.SeedInfo.seed([BE8815431FC643A2:8F1899AFBB90BC8B]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.getRouteException(CloudSolrClient.java:125)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.getRouteException(CloudSolrClient.java:46)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.directUpdate(BaseCloudSolrClient.java:491)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:977)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:837)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:769)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:177)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at
org.apache.solr.update.processor.CategoryRoutedAliasUpdateProcessorTest.testSliceRouting(CategoryRoutedAliasUpdateProcessorTest.java:371)
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)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred
while waiting response from server at:
http://127.0.0.1:38623/solr/myAlias__CRA__Heart_of_Gold_shard3_replica_n13
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:660)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at
org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
at
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
at
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.lambda$directUpdate$0(BaseCloudSolrClient.java:465)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
at
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
... 1 more
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
at
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:548)
... 10 more
Build Log:
[...truncated 12510 lines...]
[junit4] Suite: org.apache.solr.cloud.AliasIntegrationTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/init-core-data-001
[junit4] 2> 19116 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 19119 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-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> 19119 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 19124 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001
[junit4] 2> 19129 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 19140 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 19140 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 19230 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:36257
[junit4] 2> 19232 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36257
[junit4] 2> 19233 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36257
[junit4] 2> 19387 INFO (zkConnectionManagerCallback-37-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 19443 INFO (zkConnectionManagerCallback-39-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 19503 INFO (zkConnectionManagerCallback-41-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 19647 WARN (jetty-launcher-42-thread-2) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 19652 WARN (jetty-launcher-42-thread-1) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 19984 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 19984 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 19985 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 19985 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 19996 INFO (jetty-launcher-42-thread-2) [ ] o.e.j.s.Server
jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2+9
[junit4] 2> 20005 INFO (jetty-launcher-42-thread-1) [ ] o.e.j.s.Server
jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2+9
[junit4] 2> 20092 INFO (jetty-launcher-42-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 20092 INFO (jetty-launcher-42-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 20093 INFO (jetty-launcher-42-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 20103 INFO (jetty-launcher-42-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@50271aee{/solr,null,AVAILABLE}
[junit4] 2> 20171 INFO (jetty-launcher-42-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 20171 INFO (jetty-launcher-42-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 20171 INFO (jetty-launcher-42-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 20176 INFO (jetty-launcher-42-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@66e95d90{/solr,null,AVAILABLE}
[junit4] 2> 20186 INFO (jetty-launcher-42-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3afd2ead{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:37251}
[junit4] 2> 20186 INFO (jetty-launcher-42-thread-2) [ ] o.e.j.s.Server
Started @20262ms
[junit4] 2> 20186 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37251}
[junit4] 2> 20187 INFO (jetty-launcher-42-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@376705a7{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:34625}
[junit4] 2> 20187 INFO (jetty-launcher-42-thread-1) [ ] o.e.j.s.Server
Started @20264ms
[junit4] 2> 20187 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34625}
[junit4] 2> 20202 ERROR (jetty-launcher-42-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 20202 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 20202 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 20203 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 20203 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 20203 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-04-20T21:15:42.135132Z
[junit4] 2> 20203 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 20216 ERROR (jetty-launcher-42-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 20216 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 20216 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 20216 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 20216 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 20216 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-04-20T21:15:42.148598Z
[junit4] 2> 20251 INFO (zkConnectionManagerCallback-44-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 20252 INFO (zkConnectionManagerCallback-46-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 20255 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 20257 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 20702 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 20723 WARN (jetty-launcher-42-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@7f38e7fc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 20745 WARN (jetty-launcher-42-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@6d4a7372[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 20748 INFO (jetty-launcher-42-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36257/solr
[junit4] 2> 20799 INFO (zkConnectionManagerCallback-54-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 20883 INFO (zkConnectionManagerCallback-56-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 20888 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 20890 WARN (jetty-launcher-42-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@7fdad76e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 20949 WARN (jetty-launcher-42-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3d0998d2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 20950 INFO (jetty-launcher-42-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36257/solr
[junit4] 2> 20991 INFO (zkConnectionManagerCallback-64-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 21055 INFO (zkConnectionManagerCallback-66-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 21143 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37251_solr
[junit4] 2> 21145 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.Overseer Overseer
(id=72115939195748360-127.0.0.1:37251_solr-n_0000000000) starting
[junit4] 2> 21267 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34625_solr
[junit4] 2> 21283 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 21391 INFO (zkCallback-55-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 21395 INFO (zkConnectionManagerCallback-73-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 21432 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 21435 INFO (zkConnectionManagerCallback-78-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 21452 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:36257/solr ready
[junit4] 2> 21463 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 21468 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:36257/solr ready
[junit4] 2> 21479 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 21600 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34625.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21600 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34625.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21600 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34625.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21603 INFO (jetty-launcher-42-thread-1)
[n:127.0.0.1:34625_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node1/.
[junit4] 2> 21612 INFO
(OverseerStateUpdate-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:37251_solr
[junit4] 2> 21640 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:37251_solr as DOWN
[junit4] 2> 21670 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 21670 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37251_solr
[junit4] 2> 21682 INFO (zkCallback-77-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 21688 INFO (zkCallback-55-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 21692 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 21694 INFO (zkCallback-72-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 21711 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 21762 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37251.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21818 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37251.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21831 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37251.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 21833 INFO (jetty-launcher-42-thread-2)
[n:127.0.0.1:37251_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node2/.
[junit4] 2> 22001 INFO (zkConnectionManagerCallback-85-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 22003 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 22010 INFO
(SUITE-AliasIntegrationTest-seed#[BE8815431FC643A2]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36257/solr ready
[junit4] 2> 22038 INFO
(TEST-AliasIntegrationTest.testDeleteOneOfTwoCollectionsAliased-seed#[BE8815431FC643A2])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteOneOfTwoCollectionsAliased
[junit4] 2> 22184 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&name=collection_one&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 22199 INFO
(OverseerThreadFactory-81-thread-1-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
collection_one
[junit4] 2> 22344 INFO
(OverseerStateUpdate-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection_one",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection_one_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37251/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 22355 INFO
(OverseerStateUpdate-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection_one",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection_one_shard2_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:34625/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 22582 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection_one_shard1_replica_n1&action=CREATE&numShards=2&collection=collection_one&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 22582 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection_one_shard2_replica_n3&action=CREATE&numShards=2&collection=collection_one&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 22583 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 2147483647 transient cores
[junit4] 2> 23633 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 23665 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 23673 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.s.IndexSchema [collection_one_shard1_replica_n1] Schema name=minimal
[junit4] 2> 23680 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.s.IndexSchema [collection_one_shard2_replica_n3] Schema name=minimal
[junit4] 2> 23683 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 23683 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.CoreContainer Creating SolrCore 'collection_one_shard2_replica_n3'
using configuration from collection collection_one, trusted=true
[junit4] 2> 23688 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 23688 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'collection_one_shard1_replica_n1'
using configuration from collection collection_one, trusted=true
[junit4] 2> 23692 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34625.solr.core.collection_one.shard2.replica_n3' (registry
'solr.core.collection_one.shard2.replica_n3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 23693 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.SolrCore [[collection_one_shard2_replica_n3] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node1/collection_one_shard2_replica_n3],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node1/./collection_one_shard2_replica_n3/data/]
[junit4] 2> 23700 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37251.solr.core.collection_one.shard1.replica_n1' (registry
'solr.core.collection_one.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 23700 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.SolrCore [[collection_one_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node2/collection_one_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node2/./collection_one_shard1_replica_n1/data/]
[junit4] 2> 23878 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 23878 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 23892 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23892 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23897 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@40cd5ec6[collection_one_shard1_replica_n1] main]
[junit4] 2> 23903 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 23904 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 23906 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23906 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23907 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 23908 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 23909 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23909 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@2625f9d3[collection_one_shard2_replica_n3] main]
[junit4] 2> 23910 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1631369241131220992
[junit4] 2> 23910 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 23911 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 23911 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 23911 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1631369241132269568
[junit4] 2> 23933 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_one/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 23935 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_one/terms/shard2 to Terms{values={core_node4=0},
version=0}
[junit4] 2> 23939 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection_one/leaders/shard1
[junit4] 2> 23943 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection_one/leaders/shard2
[junit4] 2> 23943 INFO
(searcherExecutor-86-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3 c:collection_one s:shard2 r:core_node4)
[n:127.0.0.1:34625_solr c:collection_one s:shard2 r:core_node4
x:collection_one_shard2_replica_n3] o.a.s.c.SolrCore
[collection_one_shard2_replica_n3] Registered new searcher
Searcher@2625f9d3[collection_one_shard2_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23944 INFO
(searcherExecutor-87-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1 c:collection_one s:shard1 r:core_node2)
[n:127.0.0.1:37251_solr c:collection_one s:shard1 r:core_node2
x:collection_one_shard1_replica_n1] o.a.s.c.SolrCore
[collection_one_shard1_replica_n1] Registered new searcher
Searcher@40cd5ec6[collection_one_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23964 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 23965 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 23965 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/
[junit4] 2> 23965 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 23965 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 23965 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:34625/solr/collection_one_shard2_replica_n3/
[junit4] 2> 23966 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 23966 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 23967 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.SyncStrategy
http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/ has no replicas
[junit4] 2> 23968 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection_one/leaders/shard1/leader after winning as
/collections/collection_one/leader_elect/shard1/election/72115939195748360-core_node2-n_0000000000
[junit4] 2> 23978 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.SyncStrategy
http://127.0.0.1:34625/solr/collection_one_shard2_replica_n3/ has no replicas
[junit4] 2> 23978 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection_one/leaders/shard2/leader after winning as
/collections/collection_one/leader_elect/shard2/election/72115939195748358-core_node4-n_0000000000
[junit4] 2> 23979 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/ shard1
[junit4] 2> 23981 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:34625/solr/collection_one_shard2_replica_n3/ shard2
[junit4] 2> 24121 INFO (zkCallback-55-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24122 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24155 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24168 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 24168 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 24173 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection_one_shard2_replica_n3&action=CREATE&numShards=2&collection=collection_one&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1593
[junit4] 2> 24200 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_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=collection_one_shard1_replica_n1&action=CREATE&numShards=2&collection=collection_one&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1620
[junit4] 2> 24251 INFO (qtp1883295302-116) [n:127.0.0.1:34625_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> 24316 INFO (zkCallback-55-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24317 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24317 INFO (zkCallback-55-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24317 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24328 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&name=collection_one&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=2145
[junit4] 2> 24333 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&name=collection_two&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 24334 INFO (zkCallback-65-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 24412 INFO
(OverseerThreadFactory-81-thread-2-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
collection_two
[junit4] 2> 24416 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_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> 24686 INFO
(OverseerStateUpdate-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection_two",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection_two_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37251/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 24891 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
x:collection_two_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection_two_shard1_replica_n1&action=CREATE&numShards=1&collection=collection_two&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 25902 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 25913 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.s.IndexSchema [collection_two_shard1_replica_n1] Schema name=minimal
[junit4] 2> 25916 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 25916 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'collection_two_shard1_replica_n1'
using configuration from collection collection_two, trusted=true
[junit4] 2> 25917 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37251.solr.core.collection_two.shard1.replica_n1' (registry
'solr.core.collection_two.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75eac1df
[junit4] 2> 25917 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.SolrCore [[collection_two_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node2/collection_two_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_BE8815431FC643A2-001/tempDir-001/node2/./collection_two_shard1_replica_n1/data/]
[junit4] 2> 26057 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 26148 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 26151 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 26151 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 26163 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7f39d9b6[collection_two_shard1_replica_n1] main]
[junit4] 2> 26165 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 26165 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 26166 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 26166 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1631369243496808448
[junit4] 2> 26175 INFO
(searcherExecutor-96-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_two_shard1_replica_n1 c:collection_two s:shard1 r:core_node2)
[n:127.0.0.1:37251_solr c:collection_two s:shard1 r:core_node2
x:collection_two_shard1_replica_n1] o.a.s.c.SolrCore
[collection_two_shard1_replica_n1] Registered new searcher
Searcher@7f39d9b6[collection_two_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 26184 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_two/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 26184 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection_two/leaders/shard1
[junit4] 2> 26215 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 26215 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 26215 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:37251/solr/collection_two_shard1_replica_n1/
[junit4] 2> 26215 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 26216 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.SyncStrategy
http://127.0.0.1:37251/solr/collection_two_shard1_replica_n1/ has no replicas
[junit4] 2> 26216 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection_two/leaders/shard1/leader after winning as
/collections/collection_two/leader_elect/shard1/election/72115939195748360-core_node2-n_0000000000
[junit4] 2> 26219 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:37251/solr/collection_two_shard1_replica_n1/ shard1
[junit4] 2> 26327 INFO (zkCallback-65-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26327 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26336 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 26343 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_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=collection_two_shard1_replica_n1&action=CREATE&numShards=1&collection=collection_two&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1452
[junit4] 2> 26350 INFO (qtp1883295302-117) [n:127.0.0.1:34625_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> 26425 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_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> 26456 INFO (zkCallback-55-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26456 INFO (zkCallback-65-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26456 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26458 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_two/state.json] for collection [collection_two]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 26460 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&name=collection_two&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=2126
[junit4] 2> 26493 INFO
(TEST-AliasIntegrationTest.testDeleteOneOfTwoCollectionsAliased-seed#[BE8815431FC643A2])
[ ] o.a.s.c.SolrCloudTestCase active replica count: 2 expected replica
count: 2
[junit4] 2> 26497 INFO
(TEST-AliasIntegrationTest.testDeleteOneOfTwoCollectionsAliased-seed#[BE8815431FC643A2])
[ ] o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica
count: 1
[junit4] 2> 26497 INFO (watches-82-thread-1) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 1 expected replica count: 1
[junit4] 2> 26551 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_one/terms/shard1 to Terms{values={core_node2=1},
version=1}
[junit4] 2> 26552 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection_one_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection_one:4&wt=javabin&version=2}{add=[1
(1631369243873247232)]} 0 40
[junit4] 2> 26766 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1631369244125954048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 26767 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 26769 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 26769 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection_one_shard2_replica_n3]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 4
[junit4] 2> 26783 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1631369244143779840,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 26783 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@268476fd
commitCommandVersion:1631369244143779840
[junit4] 2> 26823 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7a84525[collection_one_shard1_replica_n1] main]
[junit4] 2> 26824 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 26829 INFO
(searcherExecutor-87-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1 c:collection_one s:shard1 r:core_node2)
[n:127.0.0.1:37251_solr c:collection_one s:shard1 r:core_node2
x:collection_one_shard1_replica_n1] o.a.s.c.SolrCore
[collection_one_shard1_replica_n1] Registered new searcher
Searcher@7a84525[collection_one_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics={lucene.version=9.0.0,
source=flush, os.arch=amd64, java.runtime.version=11.0.2+9,
os.version=4.18.0-17-generic, os=Linux, java.vendor=Oracle Corporation,
timestamp=1555794948730, java.version=11.0.2,
java.vm.version=11.0.2+9}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 26830 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection_one_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection_one:4&commit=true&wt=javabin&version=2}{commit=}
0 275
[junit4] 2> 26844 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_two/terms/shard1 to Terms{values={core_node2=1},
version=1}
[junit4] 2> 26845 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection_two_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection_two:4&wt=javabin&version=2}{add=[10
(1631369244200402944), 11 (1631369244203548672)]} 0 7
[junit4] 2> 26847 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1631369244210888704,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 26848 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5bab73b6
commitCommandVersion:1631369244210888704
[junit4] 2> 26875 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6d7660dd[collection_two_shard1_replica_n1] main]
[junit4] 2> 26877 INFO
(searcherExecutor-96-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_two_shard1_replica_n1 c:collection_two s:shard1 r:core_node2)
[n:127.0.0.1:37251_solr c:collection_two s:shard1 r:core_node2
x:collection_two_shard1_replica_n1] o.a.s.c.SolrCore
[collection_two_shard1_replica_n1] Registered new searcher
Searcher@6d7660dd[collection_two_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(9.0.0):C2:[diagnostics={lucene.version=9.0.0,
source=flush, os.arch=amd64, java.runtime.version=11.0.2+9,
os.version=4.18.0-17-generic, os=Linux, java.vendor=Oracle Corporation,
timestamp=1555794948798, java.version=11.0.2,
java.vm.version=11.0.2+9}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 26879 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 26880 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection_two_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection_two:4&commit=true&wt=javabin&version=2}{commit=}
0 33
[junit4] 2> 26882 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params
collections=collection_one,collection_two&name=collection_alias_pair&action=CREATEALIAS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 27032 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collections=collection_one,collection_two&name=collection_alias_pair&action=CREATEALIAS&wt=javabin&version=2}
status=0 QTime=150
[junit4] 2> 27116 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.S.Request [collection_two_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=collection_one:4|collection_two:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection_one,collection_two&shard.url=http://127.0.0.1:37251/solr/collection_two_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1555794948968&isShard=true&wt=javabin}
hits=2 status=0 QTime=4
[junit4] 2> 27116 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.S.Request [collection_one_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=collection_one:4|collection_two:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection_one,collection_two&shard.url=http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1555794948968&isShard=true&wt=javabin}
hits=1 status=0 QTime=7
[junit4] 2> 27124 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr
c:collection_one s:shard2 r:core_node4 x:collection_one_shard2_replica_n3]
o.a.s.c.S.Request [collection_one_shard2_replica_n3] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=collection_one:4|collection_two:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection_one,collection_two&shard.url=http://127.0.0.1:34625/solr/collection_one_shard2_replica_n3/&rows=10&version=2&q=*:*&NOW=1555794948968&isShard=true&wt=javabin}
hits=0 status=0 QTime=1
[junit4] 2> 27132 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr
c:collection_two s:shard1 r:core_node2 x:collection_two_shard1_replica_n1]
o.a.s.c.S.Request [collection_two_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&df=text&distrib=false&_stateVer_=collection_one:4|collection_two:4&shards.purpose=64&NOW=1555794948968&ids=11,10&isShard=true&collection=collection_one,collection_two&shard.url=http://127.0.0.1:37251/solr/collection_two_shard1_replica_n1/&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 27136 INFO (qtp1547041094-216) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.S.Request [collection_one_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&df=text&distrib=false&_stateVer_=collection_one:4|collection_two:4&shards.purpose=64&NOW=1555794948968&ids=1&isShard=true&collection=collection_one,collection_two&shard.url=http://127.0.0.1:37251/solr/collection_one_shard1_replica_n1/&wt=javabin&version=2}
status=0 QTime=6
[junit4] 2> 27144 INFO (qtp1547041094-124) [n:127.0.0.1:37251_solr
c:collection_one s:shard1 r:core_node2 x:collection_one_shard1_replica_n1]
o.a.s.c.S.Request [collection_one_shard1_replica_n1] webapp=/solr path=/select
params={q=*:*&_stateVer_=collection_one:4|collection_two:4&wt=javabin&version=2}
hits=3 status=0 QTime=108
[junit4] 2> 27146 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
async=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&name=collection_one&action=DELETE&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 27149 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&name=collection_one&action=DELETE&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 27152 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 27154 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 27157 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_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> 27159 ERROR
(OverseerThreadFactory-81-thread-4-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler
Collection: collection_one operation: delete
failed:org.apache.solr.common.SolrException: Collection : collection_one is
part of aliases: [collection_one, collection_alias_pair], remove or modify the
aliases before removing this collection.
[junit4] 2> at
org.apache.solr.cloud.api.collections.DeleteCollectionCmd.checkAliasReference(DeleteCollectionCmd.java:194)
[junit4] 2> at
org.apache.solr.cloud.api.collections.DeleteCollectionCmd.call(DeleteCollectionCmd.java:79)
[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> 27185 INFO
(OverseerThreadFactory-81-thread-4-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_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> 28156 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 28165 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=8
[junit4] 2> 28167 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with
params
requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=DELETESTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 28169 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=2aa47de2-8b3b-4c0d-85e9-0228080bd1dc&action=DELETESTATUS&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 28172 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params
collections=collection_two&name=collection_alias_pair&action=CREATEALIAS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 28179 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_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> 28285 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collections=collection_two&name=collection_alias_pair&action=CREATEALIAS&wt=javabin&version=2}
status=0 QTime=113
[junit4] 2> 28286 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
async=cf0125ee-3a2d-4c5f-9c15-a366646f8479&name=collection_one&action=DELETE&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 28288 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=cf0125ee-3a2d-4c5f-9c15-a366646f8479&name=collection_one&action=DELETE&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 28290 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 28291 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 28297 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000007 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 28300 INFO
(OverseerThreadFactory-81-thread-5-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler
Executing Collection
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
asyncId=cf0125ee-3a2d-4c5f-9c15-a366646f8479
[junit4] 2> 28304 INFO (qtp1547041094-125) [n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=collection_one_shard1_replica_n1&async=cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 28304 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection_one.shard1.replica_n1, tag=null
[junit4] 2> 28304 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7350143b: rootName =
solr_37251, domain = solr.core.collection_one.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.collection_one.shard1.replica_n1
/ com.codahale.metrics.MetricRegistry@38e1eed4
[junit4] 2> 28308 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=collection_one_shard2_replica_n3&async=cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 28308 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection_one.shard2.replica_n3, tag=null
[junit4] 2> 28308 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@58304b5f: rootName =
solr_34625, domain = solr.core.collection_one.shard2.replica_n3, service url =
null, agent id = null] for registry solr.core.collection_one.shard2.replica_n3
/ com.codahale.metrics.MetricRegistry@190e541c
[junit4] 2> 28316 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012
[junit4] 2> 28323 INFO (qtp1547041094-123) [n:127.0.0.1:37251_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=7
[junit4] 2> 28329 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1] o.a.s.c.SolrCore
[collection_one_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3c941e4f
[junit4] 2> 28329 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection_one.shard1.replica_n1, tag=3c941e4f
[junit4] 2> 28329 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.collection_one.shard1.leader, tag=3c941e4f
[junit4] 2> 28333 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3] o.a.s.c.SolrCore
[collection_one_shard2_replica_n3] CLOSING SolrCore
org.apache.solr.core.SolrCore@30a374d0
[junit4] 2> 28333 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection_one.shard2.replica_n3, tag=30a374d0
[junit4] 2> 28333 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.collection_one.shard2.leader, tag=30a374d0
[junit4] 2> 28349 INFO
(parallelCoreAdminExecutor-82-thread-1-processing-n:127.0.0.1:37251_solr
x:collection_one_shard1_replica_n1
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012 UNLOAD)
[n:127.0.0.1:37251_solr x:collection_one_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_one/terms/shard1 to Terms{values={}, version=2}
[junit4] 2> 28349 INFO
(parallelCoreAdminExecutor-75-thread-1-processing-n:127.0.0.1:34625_solr
x:collection_one_shard2_replica_n3
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372 UNLOAD)
[n:127.0.0.1:34625_solr x:collection_one_shard2_replica_n3]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection_one/terms/shard2 to Terms{values={}, version=1}
[junit4] 2> 28453 INFO (zkCallback-65-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 28453 INFO (zkCallback-55-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 28453 INFO (zkCallback-55-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 28453 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 28453 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 29293 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 29296 INFO (qtp1883295302-115) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 29326 INFO (qtp1547041094-216) [n:127.0.0.1:37251_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012
[junit4] 2> 29326 INFO (qtp1547041094-216) [n:127.0.0.1:37251_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479890285500890012&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 29330 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CoreAdminOperation Checking request status for :
cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372
[junit4] 2> 29330 INFO (qtp1883295302-116) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479890285502478372&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 29435 INFO (zkCallback-65-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 29435 INFO (zkCallback-65-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 29435 INFO (zkCallback-65-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 29435 INFO (zkCallback-65-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDeleted
path:/collections/collection_one/state.json] for collection [collection_one]
has occurred - updating... (live nodes size: [2])
[junit4] 2> 29450 INFO
(OverseerThreadFactory-81-thread-5-processing-n:127.0.0.1:37251_solr)
[n:127.0.0.1:37251_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000009 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 30298 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 30299 INFO
(OverseerCollectionConfigSetProcessor-72115939195748360-127.0.0.1:37251_solr-n_0000000000)
[n:127.0.0.1:37251_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000009 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 30301 INFO (qtp1883295302-117) [n:127.0.0.1:34625_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=cf0125ee-3a2d-4c5f-9c15-a366646f8479&action=REQUESTSTATUS&wt=javabin&version=2}
status
[...truncated too long message...]
erms/shard1
[junit4] 2> 3
/solr/collections/myAlias__CRA__Heart_of_Gold/terms/shard1
[junit4] 2> 3
/solr/collections/myAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/terms/shard1
[junit4] 2> 2
/solr/collections/testMaxCardinality/terms/shard1
[junit4] 2> 2
/solr/collections/myAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/collections/testMaxCardinality/state.json
[junit4] 2> 6
/solr/collections/myAlias__CRA__Constructor/state.json
[junit4] 2> 6
/solr/collections/myAlias__CRA__Heart_of_Gold/state.json
[junit4] 2> 6
/solr/collections/myAlias__CRA__NEW_CATEGORY_ROUTED_ALIAS_WAITING_FOR_DATA__TEMP/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> 2998500 INFO
(TEST-CategoryRoutedAliasUpdateProcessorTest.testMaxCardinality-seed#[BE8815431FC643A2])
[ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33187
[junit4] 2> 2998500 INFO
(TEST-CategoryRoutedAliasUpdateProcessorTest.testMaxCardinality-seed#[BE8815431FC643A2])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33187
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.processor.CategoryRoutedAliasUpdateProcessorTest_BE8815431FC643A2-001
[junit4] 2> Apr 20, 2019 10:05:20 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 5 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
chunkSize=7, maxDocsPerChunk=9, blockSize=6),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
chunkSize=7, blockSize=6)),
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5dca2f3b),
locale=kln, timezone=America/Thunder_Bay
[junit4] 2> NOTE: Linux 4.18.0-17-generic amd64/Oracle Corporation 11.0.2
(64-bit)/cpus=8,threads=1,free=187376152,total=484442112
[junit4] 2> NOTE: All tests run in this JVM: [JSONWriterTest,
UpdateLogTest, TestComplexPhraseQParserPlugin, TestBM25SimilarityFactory,
TestSha256AuthenticationProvider, SliceStateTest, AliasIntegrationTest,
TestLockTree, TestSimpleTextCodec, HighlighterMaxOffsetTest, SolrCoreTest,
QueryResultKeyTest, ScheduledMaintenanceTriggerTest, CdcrBidirectionalTest,
TestInPlaceUpdatesRequiredField, TestReplicaProperties, TestQueryTypes,
ForceLeaderWithTlogReplicasTest, TestLMJelinekMercerSimilarityFactory,
TestDynamicURP, NodeLostTriggerTest, DistribDocExpirationUpdateProcessorTest,
PrimUtilsTest, TestShortCircuitedRequests, DistributedVersionInfoTest,
SoftAutoCommitTest, TriggerIntegrationTest, DeleteShardTest,
DistributedFacetSimpleRefinementLongTailTest, TestNestedUpdateProcessor,
SolrJmxReporterCloudTest, TestDistributedMap, CloudExitableDirectoryReaderTest,
StatsComponentTest, BJQParserTest, BadCopyFieldTest, TestFieldCacheWithThreads,
TestJsonFacets, SecurityConfHandlerTest, TestDynamicFieldCollectionResource,
MoveReplicaHDFSFailoverTest, ZkFailoverTest, BitVectorTest,
TestDistributedSearch, TestSearcherReuse, DistributedSuggestComponentTest,
TestSchemaNameResource, TestBulkSchemaConcurrent,
TestCollectionsAPIViaSolrCloudCluster, TestXIncludeConfig,
SpellCheckCollatorTest, WrapperMergePolicyFactoryTest,
ConfigureRecoveryStrategyTest, TestFiltering, FieldMutatingUpdateProcessorTest,
PeerSyncReplicationTest, AnalyticsQueryTest, PeerSyncTest,
ZookeeperStatusHandlerTest, BasicAuthStandaloneTest, HttpPartitionOnCommitTest,
TestSolr4Spatial, ExitableDirectoryReaderTest, ConcurrentCreateRoutedAliasTest,
ReplaceNodeTest, ExternalFileFieldSortTest, TestCryptoKeys,
SolrMetricReporterTest, CustomTermsComponentTest, TestFuzzyAnalyzedSuggestions,
TestCSVResponseWriter, SchemaApiFailureTest, TestRestManager,
TestRetrieveFieldsOptimizer, TestValueSourceCache, MetricsConfigTest,
QueryParsingTest, TestRandomFaceting, DateFieldTest,
ConcurrentDeleteAndCreateCollectionTest, TestMultiWordSynonyms,
TestPrepRecovery, TestPerFieldSimilarity, TestMergePolicyConfig,
TestPartialUpdateDeduplication, TestWriterPerf, SuggesterFSTTest,
SolrInfoBeanTest, TestLuceneMatchVersion, LeaderVoteWaitTimeoutTest,
TestUseDocValuesAsStored2, RollingRestartTest, ResponseHeaderTest,
DocValuesMultiTest, DisMaxRequestHandlerTest, MultiSolrCloudTestCaseTest,
TestPayloadCheckQParserPlugin, TestRandomFlRTGCloud, HdfsDirectoryTest,
ProtectedTermFilterFactoryTest, AddSchemaFieldsUpdateProcessorFactoryTest,
SpellingQueryConverterTest, TestFacetMethods, TestRealTimeGet,
HdfsNNFailoverTest, TestSimExecutePlanAction, DistributedExpandComponentTest,
TestHashQParserPlugin, BlockJoinFacetSimpleTest,
MultiDestinationAuditLoggerTest, HLLSerializationTest,
AutoAddReplicasPlanActionTest, TestChildDocTransformerHierarchy,
TimeZoneUtilsTest, TestConfigSetImmutable, ResourceLoaderTest,
DistributedFacetPivotLongTailTest, TestJsonRequest, TestOrdValues,
ZkStateWriterTest, LeaderElectionContextKeyTest,
TestSolrConfigHandlerConcurrent, AuditLoggerIntegrationTest, AtomicUpdatesTest,
TestCloudJSONFacetJoinDomain, LoggingHandlerTest, AnalysisErrorHandlingTest,
BasicFunctionalityTest, ShardsWhitelistTest, SolrXmlInZkTest,
DocumentAnalysisRequestHandlerTest, UpdateRequestProcessorFactoryTest,
TestNestedDocsSort, TestAddFieldRealTimeGet, TestExceedMaxTermLength,
OverseerCollectionConfigSetProcessorTest, TestHdfsBackupRestoreCore,
FileUtilsTest, ClassificationUpdateProcessorIntegrationTest,
CreateCollectionCleanupTest, DeleteInactiveReplicaTest,
LeaderFailureAfterFreshStartTest, NodeMutatorTest,
OutOfBoxZkACLAndCredentialsProvidersTest, OverseerRolesTest, RecoveryZkTest,
SyncSliceTest, TestCloudDeleteByQuery, TestCloudRecovery2,
TestCloudSearcherWarming, TestSizeLimitedDistributedMap,
TestSkipOverseerOperations, TestStressLiveNodes, TestZkChroot,
VMParamsZkACLAndCredentialsProvidersTest, ZkNodePropsTest, ZkShardTermsTest,
ZkSolrClientTest, AssignTest, CollectionReloadTest, CustomCollectionTest,
AutoScalingHandlerTest, ComputePlanActionTest, NodeAddedTriggerIntegrationTest,
NodeAddedTriggerTest, TestPolicyCloud, TestSimClusterStateProvider,
TestSimNodeLostTrigger, TestSimPolicyCloud, CdcrVersionReplicationTest,
BlobRepositoryCloudTest, ByteBuffersDirectoryFactoryTest, CoreSorterTest,
HdfsDirectoryFactoryTest, TestCodecSupport, TestConfig, TestCoreContainer,
TestCustomStream, TestSolrDeletionPolicy2, TestSolrCloudSnapshots,
TestConfigReload, TestReqParamsAPI, V2ApiIntegrationTest,
AdminHandlersProxyTest, CoreAdminCreateDiscoverTest, CoreAdminHandlerTest,
CoreAdminOperationTest, CoreAdminRequestStatusTest,
CoreMergeIndexesAdminHandlerTest, MBeansHandlerTest,
DistributedFacetPivotSmallTest, DistributedQueryComponentOptimizationTest,
QueryElevationComponentTest, TermVectorComponentDistributedTest,
JavabinLoaderTest, Tagger2Test, XmlInterpolationTest,
TestUnifiedSolrHighlighter, TestLegacyField, TestLegacyFieldReuse,
TestLegacyTerms, TestMultiValuedNumericRangeQuery, TestNumericTokenStream,
TestLogWatcher, SolrCoreMetricManagerTest, SolrSlf4jReporterTest,
SolrShardReporterTest, RegexBytesRefFilterTest, SimpleFacetsTest, TestFaceting,
TestIntervalFaceting, TestRangeQuery, TestRecovery, TestDFISimilarityFactory,
TestDFRSimilarityFactory, TestIBSimilarityFactory,
TestSweetSpotSimilarityFactory, TestExactSharedStatsCache,
PKIAuthenticationIntegrationTest, SolrLogAuditLoggerPluginTest,
TestAuthorizationFramework, SuggesterWFSTTest, TestBlendedInfixSuggestions,
BlockCacheTest, TestDocTermOrdsUninvertLimit, TestFieldCacheReopen,
TestNumericTerms32, PeerSyncWithIndexFingerprintCachingTest,
SolrIndexMetricsTest, CategoryRoutedAliasUpdateProcessorTest]
[junit4] Completed [854/854 (2!)] on J1 in 747.96s, 6 tests, 1 error <<<
FAILURES!
[...truncated 1 lines...]
[junit4] JVM J1: stdout was not empty, see:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J1-20190420_211521_7973130069127985571841.sysout
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to
/home/jenkins/workspace/Lucene-Solr-master-Linux/heapdumps/java_pid16718.hprof
...
[junit4] Heap dump file created [517529937 bytes in 2.814 secs]
[junit4] <<< JVM J1: EOF ----
[...truncated 8956 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:634: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:586: Some of the
tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid16718.hprof
Total time: 102 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
