Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/856/
Java: 64bit/jdk-9.0.1 -XX:+UseCompressedOops -XX:+UseParallelGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.analytics.NoFacetTest
Error Message:
org.apache.http.ParseException: Invalid content type:
Stack Trace:
org.apache.solr.client.solrj.SolrServerException:
org.apache.http.ParseException: Invalid content type:
at __randomizedtesting.SeedInfo.seed([F6C89E26BB727660]:0)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:523)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at
org.apache.solr.analytics.SolrAnalyticsTestCase.setupCollection(SolrAnalyticsTestCase.java:62)
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:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:844)
Caused by: org.apache.http.ParseException: Invalid content type:
at org.apache.http.entity.ContentType.parse(ContentType.java:298)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:591)
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.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
... 30 more
FAILED: org.apache.solr.cloud.AddReplicaTest.test
Error Message:
core_node6:{"core":"addreplicatest_coll_shard1_replica_n5","base_url":"https://127.0.0.1:39389/solr","node_name":"127.0.0.1:39389_solr","state":"active","type":"NRT"}
Stack Trace:
java.lang.AssertionError:
core_node6:{"core":"addreplicatest_coll_shard1_replica_n5","base_url":"https://127.0.0.1:39389/solr","node_name":"127.0.0.1:39389_solr","state":"active","type":"NRT"}
at
__randomizedtesting.SeedInfo.seed([60CEE0CB6648DCBE:E89ADF11C8B4B146]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.AddReplicaTest.test(AddReplicaTest.java:84)
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:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:844)
FAILED: org.apache.solr.cloud.ShardSplitTest.testSplitStaticIndexReplication
Error Message:
Timeout occured while waiting response from server at:
http://127.0.0.1:40059/cvtw/p
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:40059/cvtw/p
at
__randomizedtesting.SeedInfo.seed([60CEE0CB6648DCBE:2A8474CBF7E0F3BB]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:654)
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.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:314)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:991)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
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:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:844)
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:116)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:141)
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:111)
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:542)
... 42 more
Build Log:
[...truncated 11583 lines...]
[junit4] Suite: org.apache.solr.cloud.AddReplicaTest
[junit4] 2> 10209 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/init-core-data-001
[junit4] 2> 10210 WARN
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=16 numCloses=16
[junit4] 2> 10210 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 10211 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 10213 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001
[junit4] 2> 10217 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 10218 INFO (Thread-2) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 10219 INFO (Thread-2) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 10315 ERROR (Thread-2) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 10318 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:43609
[junit4] 2> 10455 INFO (jetty-launcher-5-thread-1) [ ] o.e.j.s.Server
jetty-9.3.20.v20170531
[junit4] 2> 10455 INFO (jetty-launcher-5-thread-4) [ ] o.e.j.s.Server
jetty-9.3.20.v20170531
[junit4] 2> 10455 INFO (jetty-launcher-5-thread-3) [ ] o.e.j.s.Server
jetty-9.3.20.v20170531
[junit4] 2> 10455 INFO (jetty-launcher-5-thread-2) [ ] o.e.j.s.Server
jetty-9.3.20.v20170531
[junit4] 2> 10470 INFO (jetty-launcher-5-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@383ff341{/solr,null,AVAILABLE}
[junit4] 2> 10470 INFO (jetty-launcher-5-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5f4a60cd{/solr,null,AVAILABLE}
[junit4] 2> 10470 INFO (jetty-launcher-5-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@15e90857{/solr,null,AVAILABLE}
[junit4] 2> 10470 INFO (jetty-launcher-5-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@44fcac7a{/solr,null,AVAILABLE}
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@42db3e0c{SSL,[ssl,
http/1.1]}{127.0.0.1:38981}
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4a532bc0{SSL,[ssl,
http/1.1]}{127.0.0.1:39389}
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@36343e6d{SSL,[ssl,
http/1.1]}{127.0.0.1:32805}
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6df80996{SSL,[ssl,
http/1.1]}{127.0.0.1:46233}
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-2) [ ] o.e.j.s.Server
Started @22283ms
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-1) [ ] o.e.j.s.Server
Started @22283ms
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-4) [ ] o.e.j.s.Server
Started @22283ms
[junit4] 2> 10486 INFO (jetty-launcher-5-thread-3) [ ] o.e.j.s.Server
Started @22283ms
[junit4] 2> 10487 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=46233}
[junit4] 2> 10487 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38981}
[junit4] 2> 10487 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39389}
[junit4] 2> 10487 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=32805}
[junit4] 2> 10494 ERROR (jetty-launcher-5-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 10494 ERROR (jetty-launcher-5-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 10494 ERROR (jetty-launcher-5-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 10494 ERROR (jetty-launcher-5-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 10494 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 10494 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 10494 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 10494 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 10495 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 10498 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-19T13:02:41.352386Z
[junit4] 2> 10498 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-19T13:02:41.352384Z
[junit4] 2> 10498 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-19T13:02:41.352389Z
[junit4] 2> 10498 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-19T13:02:41.352391Z
[junit4] 2> 10519 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 10519 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 10519 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 10520 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 10531 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fd45fadd60001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 10543 INFO (jetty-launcher-5-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43609/solr
[junit4] 2> 10543 INFO (jetty-launcher-5-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43609/solr
[junit4] 2> 10546 INFO (jetty-launcher-5-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43609/solr
[junit4] 2> 10550 INFO (jetty-launcher-5-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43609/solr
[junit4] 2> 10563 DEBUG (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$348/1403612233@4b15956
[junit4] 2> 10564 DEBUG (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$348/1403612233@20824c4b
[junit4] 2> 10564 DEBUG (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$348/1403612233@72d34668
[junit4] 2> 10564 DEBUG (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$348/1403612233@e1888d9
[junit4] 2> 10728 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterprops.json
[junit4] 2> 10729 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterprops.json
[junit4] 2> 10730 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10731 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10731 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterstate.json
[junit4] 2> 10731 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterstate.json
[junit4] 2> 10733 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 10733 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 10733 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/aliases.json
[junit4] 2> 10733 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/aliases.json
[junit4] 2> 10736 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterprops.json
[junit4] 2> 10736 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/security.json
[junit4] 2> 10736 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/security.json
[junit4] 2> 10736 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10737 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterstate.json
[junit4] 2> 10737 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 10737 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/aliases.json
[junit4] 2> 10738 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/security.json
[junit4] 2> 10739 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterprops.json
[junit4] 2> 10739 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10739 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterstate.json
[junit4] 2> 10739 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 10740 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/aliases.json
[junit4] 2> 10740 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/security.json
[junit4] 2> 10741 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 10741 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 10742 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 10742 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 10742 DEBUG (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/99031224228904970-127.0.0.1:38981_solr-n_0000000000
[junit4] 2> 10742 DEBUG (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/99031224228904971-127.0.0.1:39389_solr-n_0000000001
[junit4] 2> 10743 DEBUG (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/99031224228904969-127.0.0.1:32805_solr-n_0000000003
[junit4] 2> 10743 DEBUG (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/99031224228904972-127.0.0.1:46233_solr-n_0000000002
[junit4] 2> 10743 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:38981_solr
[junit4] 2> 10744 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data:
/solr/overseer_elect/election/99031224228904970-127.0.0.1:38981_solr-n_0000000000
[junit4] 2> 10744 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data:
/solr/overseer_elect/election/99031224228904971-127.0.0.1:39389_solr-n_0000000001
[junit4] 2> 10744 DEBUG (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/99031224228904970-127.0.0.1:38981_solr-n_0000000000 to
know if I could be the leader
[junit4] 2> 10744 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data:
/solr/overseer_elect/election/99031224228904972-127.0.0.1:46233_solr-n_0000000002
[junit4] 2> 10744 DEBUG (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/99031224228904972-127.0.0.1:46233_solr-n_0000000002 to
know if I could be the leader
[junit4] 2> 10744 DEBUG (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/99031224228904971-127.0.0.1:39389_solr-n_0000000001 to
know if I could be the leader
[junit4] 2> 10744 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39389_solr
[junit4] 2> 10745 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:32805_solr
[junit4] 2> 10745 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46233_solr
[junit4] 2> 10745 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer Overseer
(id=99031224228904970-127.0.0.1:38981_solr-n_0000000000) starting
[junit4] 2> 10751 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10751 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10752 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10752 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10752 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10752 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10752 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10753 INFO
(zkCallback-25-thread-1-processing-n:127.0.0.1:32805_solr)
[n:127.0.0.1:32805_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 10754 INFO
(zkCallback-27-thread-1-processing-n:127.0.0.1:46233_solr)
[n:127.0.0.1:46233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 10754 INFO
(zkCallback-24-thread-1-processing-n:127.0.0.1:39389_solr)
[n:127.0.0.1:39389_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 10757 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10757 INFO
(zkCallback-26-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 10850 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Process current
queue of overseer operations
[junit4] 2> 10855 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Cleaning up
work-queue. #Running tasks: 0
[junit4] 2> 10856 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor RunningTasks: []
[junit4] 2> 10856 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
[junit4] 2> 10856 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
[junit4] 2> 10856 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor RunningZKTasks: []
[junit4] 2> 10856 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskQueue Peeking for top 100
elements. ExcludeSet: []
[junit4] 2> 10858 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/collection-queue-work
[junit4] 2> 10858 DEBUG (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:38981_solr as DOWN
[junit4] 2> 10860 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38981_solr
[junit4] 2> 10862 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 10883 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10883 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10883 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10883 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/live_nodes
[junit4] 2> 10884 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10884 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10884 INFO
(zkCallback-27-thread-1-processing-n:127.0.0.1:46233_solr)
[n:127.0.0.1:46233_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 10884 INFO
(zkCallback-25-thread-1-processing-n:127.0.0.1:32805_solr)
[n:127.0.0.1:32805_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 10884 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10884 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 10884 INFO
(zkCallback-24-thread-1-processing-n:127.0.0.1:39389_solr)
[n:127.0.0.1:39389_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 10885 INFO
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 10886 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue-work
[junit4] 2> 10887 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 10888 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:38981_solr"} current state version: 0
[junit4] 2> 10890 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for
node: 127.0.0.1:38981_solr
[junit4] 2> 10900 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread Adding
.autoAddReplicas trigger
[junit4] 2> 10915 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/autoscaling.json
[junit4] 2> 10915 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing
/autoscaling.json with znode version 1
[junit4] 2> 10943 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes:
[127.0.0.1:39389_solr, 127.0.0.1:32805_solr, 127.0.0.1:46233_solr,
127.0.0.1:38981_solr]
[junit4] 2> 10943 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 1, lastZnodeVersion -1
[junit4] 2> 10943 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger
updates upto znodeVersion 1
[junit4] 2> 10973 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old
nodeAdded markers
[junit4] 2> 10974 DEBUG
(OverseerAutoScalingTriggerThread-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.OverseerTriggerThread Current
znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 10986 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 10986 DEBUG (ScheduledTrigger-51-thread-1)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: [127.0.0.1:39389_solr,
127.0.0.1:32805_solr, 127.0.0.1:46233_solr, 127.0.0.1:38981_solr]
[junit4] 2> 11011 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11014 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11058 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39389.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11059 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39389.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11059 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39389.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11071 INFO (jetty-launcher-5-thread-1)
[n:127.0.0.1:39389_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node1/.
[junit4] 2> 11181 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32805.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11202 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38981.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11202 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46233.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11215 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32805.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11215 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_32805.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11226 INFO (jetty-launcher-5-thread-3)
[n:127.0.0.1:32805_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node3/.
[junit4] 2> 11259 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46233.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11259 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_46233.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11260 INFO (jetty-launcher-5-thread-4)
[n:127.0.0.1:46233_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node4/.
[junit4] 2> 11261 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38981.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11262 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38981.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 11264 INFO (jetty-launcher-5-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node2/.
[junit4] 2> 11486 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterprops.json
[junit4] 2> 11486 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/live_nodes
[junit4] 2> 11487 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 11488 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/clusterstate.json
[junit4] 2> 11489 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11489 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/aliases.json
[junit4] 2> 11489 INFO
(SUITE-AddReplicaTest-seed#[60CEE0CB6648DCBE]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43609/solr ready
[junit4] 2> 11512 INFO (TEST-AddReplicaTest.test-seed#[60CEE0CB6648DCBE])
[ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 11727 INFO (qtp1354574400-80) [n:127.0.0.1:39389_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&maxShardsPerNode=2&name=addreplicatest_coll&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 11737 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/collection-queue-work
[junit4] 2> 11737 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/collection-queue-work
[junit4] 2> 11738 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.ZkDistributedQueue Found child node with
improper name: qnr-0000000000
[junit4] 2> 11738 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/overseer/collection-queue-work/qnr-0000000000
[junit4] 2> 11739 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/collection-queue-work
[junit4] 2> 11740 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/collection-queue-work
[junit4] 2> 11740 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.ZkDistributedQueue Found child node with
improper name: qnr-0000000000
[junit4] 2> 11740 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskQueue Returning topN
elements: [/overseer/collection-queue-work/qn-0000000000, ]
[junit4] 2> 11741 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Got 1 tasks from
work-queue : [[org.apache.solr.cloud.OverseerTaskQueue$QueueEvent@2e684ecf]]
[junit4] 2> 11742 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Marked task
[/overseer/collection-queue-work/qn-0000000000] as running
[junit4] 2> 11742 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Overseer Collection
Message Handler: Get the message
id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"addreplicatest_coll",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 11743 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Runner processing
/overseer/collection-queue-work/qn-0000000000
[junit4] 2> 11743 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerCollectionMessageHandler
OverseerCollectionMessageHandler.processMessage : create , {
[junit4] 2> "name":"addreplicatest_coll",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 11743 INFO
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Create collection
addreplicatest_coll
[junit4] 2> 11743 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor Cleaning up
work-queue. #Running tasks: 1
[junit4] 2> 11743 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor RunningTasks:
[/overseer/collection-queue-work/qn-0000000000]
[junit4] 2> 11744 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor BlockedTasks: []
[junit4] 2> 11744 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor CompletedTasks: []
[junit4] 2> 11744 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskProcessor RunningZKTasks:
[/overseer/collection-queue-work/qn-0000000000]
[junit4] 2> 11744 DEBUG
(OverseerCollectionConfigSetProcessor-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerTaskQueue Peeking for top 99
elements. ExcludeSet: [/overseer/collection-queue-work/qn-0000000000],[]
[junit4] 2> 11747 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.Assign Identify nodes using default
[junit4] 2> 11748 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerCollectionMessageHandler creating
collections conf node /collections/addreplicatest_coll
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/collections
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/collections
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/collections
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/collections
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/collections
[junit4] 2> 11749 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11750 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11750 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11753 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11753 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/collections
[junit4] 2> 11754 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Check for collection
zkNode:addreplicatest_coll
[junit4] 2> 11754 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Collection zkNode
exists
[junit4] 2> 11755 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11756 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11757 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "name":"addreplicatest_coll",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 11757 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ClusterStateMutator building a new
cName: addreplicatest_coll
[junit4] 2> 11759 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/addreplicatest_coll/state.json
[junit4] 2> 11760 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11761 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11859 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Creating SolrCores for
new collection addreplicatest_coll, shardNames [shard1, shard2] , nrtReplicas :
1, tlogReplicas: 0, pullReplicas: 0
[junit4] 2> 11862 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Creating core
addreplicatest_coll_shard1_replica_n1 as part of shard shard1 of collection
addreplicatest_coll on 127.0.0.1:32805_solr
[junit4] 2> 11864 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11864 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11865 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 11866 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.CreateCollectionCmd Creating core
addreplicatest_coll_shard2_replica_n2 as part of shard shard2 of collection
addreplicatest_coll on 127.0.0.1:46233_solr
[junit4] 2> 11866 INFO
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 11867 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11868 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerCollectionMessageHandler Expecting
2 cores but found 0
[junit4] 2> 11868 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 11868 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 11869 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11869 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 2,
message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 11869 INFO
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 11870 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 11870 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node4":{
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 11968 DEBUG
(OverseerThreadFactory-53-thread-1-processing-n:127.0.0.1:38981_solr)
[n:127.0.0.1:38981_solr ] o.a.s.c.OverseerCollectionMessageHandler Expecting
2 cores but found 0
[junit4] 2> 11971 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/addreplicatest_coll/state.json version: 0
[junit4] 2> 11972 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 11973 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 11995 DEBUG (ScheduledTrigger-51-thread-1)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: [127.0.0.1:39389_solr,
127.0.0.1:32805_solr, 127.0.0.1:46233_solr, 127.0.0.1:38981_solr]
[junit4] 2> 12118 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf1&newCollection=true&name=addreplicatest_coll_shard2_replica_n2&action=CREATE&numShards=2&collection=addreplicatest_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 12119 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 12121 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=addreplicatest_coll_shard1_replica_n1&action=CREATE&numShards=2&collection=addreplicatest_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 12121 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 12133 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12134 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12135 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ZkController publishing
state=down
[junit4] 2> 12136 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ZkController publishing
state=down
[junit4] 2> 12137 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 12137 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 12138 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ZkController Registering watch
for collection addreplicatest_coll
[junit4] 2> 12138 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 2,
message = {
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "node_name":"127.0.0.1:46233_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 12140 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "node_name":"127.0.0.1:46233_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"state"}
[junit4] 2> 12141 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica:
core_node4:{"core":"addreplicatest_coll_shard2_replica_n2","base_url":"https://127.0.0.1:46233/solr","node_name":"127.0.0.1:46233_solr","state":"down","type":"NRT"}
[junit4] 2> 12141 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(addreplicatest_coll//collections/addreplicatest_coll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node4":{
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "node_name":"127.0.0.1:46233_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 12141 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.Overseer processMessage: queueSize: 2,
message = {
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "node_name":"127.0.0.1:32805_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 12141 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "node_name":"127.0.0.1:32805_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"addreplicatest_coll",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"state"}
[junit4] 2> 12142 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Will update state for
replica:
core_node3:{"core":"addreplicatest_coll_shard1_replica_n1","base_url":"https://127.0.0.1:32805/solr","node_name":"127.0.0.1:32805_solr","state":"down","type":"NRT"}
[junit4] 2> 12142 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ReplicaMutator Collection is now:
DocCollection(addreplicatest_coll//collections/addreplicatest_coll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"addreplicatest_coll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:32805/solr";,
[junit4] 2> "node_name":"127.0.0.1:32805_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node4":{
[junit4] 2> "core":"addreplicatest_coll_shard2_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:46233/solr";,
[junit4] 2> "node_name":"127.0.0.1:46233_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 12142 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12142 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ZkController Registering watch
for collection addreplicatest_coll
[junit4] 2> 12142 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ZkController waiting to find
shard id in clusterstate for addreplicatest_coll_shard2_replica_n2
[junit4] 2> 12143 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12143 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ZkController waiting to find
shard id in clusterstate for addreplicatest_coll_shard1_replica_n1
[junit4] 2> 12243 DEBUG
(OverseerStateUpdate-99031224228904970-127.0.0.1:38981_solr-n_0000000000)
[n:127.0.0.1:38981_solr ] o.a.s.c.o.ZkStateWriter going to update_collection
/collections/addreplicatest_coll/state.json version: 1
[junit4] 2> 12243 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12243 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12243 INFO
(zkCallback-25-thread-1-processing-n:127.0.0.1:32805_solr)
[n:127.0.0.1:32805_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addreplicatest_coll/state.json] for collection
[addreplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 12243 INFO
(zkCallback-27-thread-1-processing-n:127.0.0.1:46233_solr)
[n:127.0.0.1:46233_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addreplicatest_coll/state.json] for collection
[addreplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 12243 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 12244 INFO
(zkCallback-25-thread-2-processing-n:127.0.0.1:32805_solr)
[n:127.0.0.1:32805_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addreplicatest_coll/state.json] for collection
[addreplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 12244 INFO
(zkCallback-27-thread-2-processing-n:127.0.0.1:46233_solr)
[n:127.0.0.1:46233_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addreplicatest_coll/state.json] for collection
[addreplicatest_coll] has occurred - updating... (live nodes size: [4])
[junit4] 2> 12244 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12244 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12244 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12244 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: data: /solr/collections/addreplicatest_coll/state.json
[junit4] 2> 12244 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 12996 DEBUG (ScheduledTrigger-51-thread-2)
[n:127.0.0.1:38981_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger:
.auto_add_replicas with currently live nodes: [127.0.0.1:39389_solr,
127.0.0.1:32805_solr, 127.0.0.1:46233_solr, 127.0.0.1:38981_solr]
[junit4] 2> 13155 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.2.0
[junit4] 2> 13155 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.2.0
[junit4] 2> 13165 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.s.IndexSchema
[addreplicatest_coll_shard1_replica_n1] Schema name=minimal
[junit4] 2> 13165 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.s.IndexSchema
[addreplicatest_coll_shard2_replica_n2] Schema name=minimal
[junit4] 2> 13168 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 13168 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 13168 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.CoreContainer Creating
SolrCore 'addreplicatest_coll_shard1_replica_n1' using configuration from
collection addreplicatest_coll, trusted=true
[junit4] 2> 13168 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'addreplicatest_coll_shard2_replica_n2' using configuration from
collection addreplicatest_coll, trusted=true
[junit4] 2> 13170 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_32805.solr.core.addreplicatest_coll.shard1.replica_n1'
(registry 'solr.core.addreplicatest_coll.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 13170 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 13171 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SolrCore
[[addreplicatest_coll_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node3/addreplicatest_coll_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node3/./addreplicatest_coll_shard1_replica_n1/data/]
[junit4] 2> 13175 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_46233.solr.core.addreplicatest_coll.shard2.replica_n2'
(registry 'solr.core.addreplicatest_coll.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1120b181
[junit4] 2> 13175 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 13176 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SolrCore
[[addreplicatest_coll_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node4/addreplicatest_coll_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.AddReplicaTest_60CEE0CB6648DCBE-001/tempDir-001/node4/./addreplicatest_coll_shard2_replica_n2/data/]
[junit4] 2> 13291 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 13291 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 13293 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 13294 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 13296 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2d1645b2[addreplicatest_coll_shard1_replica_n1] main]
[junit4] 2> 13299 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 13300 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 13300 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 13300 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.u.UpdateLog Initializing
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 13300 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 13302 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 13302 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 13308 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening
[Searcher@28c8898d[addreplicatest_coll_shard2_replica_n2] main]
[junit4] 2> 13310 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 13311 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584499590867976192
[junit4] 2> 13311 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 13313 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ZkController watch zkdir
/configs/conf1
[junit4] 2> 13324 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 13325 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/configs/conf1
[junit4] 2> 13325 INFO
(searcherExecutor-62-thread-1-processing-n:127.0.0.1:32805_solr
x:addreplicatest_coll_shard1_replica_n1 s:shard1 c:addreplicatest_coll
r:core_node3) [n:127.0.0.1:32805_solr c:addreplicatest_coll s:shard1
r:core_node3 x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SolrCore
[addreplicatest_coll_shard1_replica_n1] Registered new searcher
Searcher@2d1645b2[addreplicatest_coll_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13325 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max
version in index or recent updates, using new clock 1584499590882656256
[junit4] 2> 13325 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ZkController Register replica
- core:addreplicatest_coll_shard1_replica_n1
address:https://127.0.0.1:32805/solr collection:addreplicatest_coll shard:shard1
[junit4] 2> 13326 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ZkController watch zkdir
/configs/conf1
[junit4] 2> 13329 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: create/delete: /solr/configs/conf1
[junit4] 2> 13329 INFO
(searcherExecutor-63-thread-1-processing-n:127.0.0.1:46233_solr
x:addreplicatest_coll_shard2_replica_n2 s:shard2 c:addreplicatest_coll
r:core_node4) [n:127.0.0.1:46233_solr c:addreplicatest_coll s:shard2
r:core_node4 x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SolrCore
[addreplicatest_coll_shard2_replica_n2] Registered new searcher
Searcher@28c8898d[addreplicatest_coll_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 13331 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ZkController Register replica
- core:addreplicatest_coll_shard2_replica_n2
address:https://127.0.0.1:46233/solr collection:addreplicatest_coll shard:shard2
[junit4] 2> 13336 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.LeaderElector Joined
leadership election with path:
/collections/addreplicatest_coll/leader_elect/shard1/election/99031224228904969-core_node3-n_0000000000
[junit4] 2> 13336 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Running the leader process for shard=shard1 and weAreReplacement=false and
leaderVoteWait=10000
[junit4] 2> 13337 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.LeaderElector Joined
leadership election with path:
/collections/addreplicatest_coll/leader_elect/shard2/election/99031224228904972-core_node4-n_0000000000
[junit4] 2> 13337 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext
Running the leader process for shard=shard2 and weAreReplacement=false and
leaderVoteWait=10000
[junit4] 2> 13338 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 13338 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 13338 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:32805/solr/addreplicatest_coll_shard1_replica_n1/
[junit4] 2> 13339 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 13339 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I
may be the new leader - try and sync
[junit4] 2> 13339 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:46233/solr/addreplicatest_coll_shard2_replica_n2/
[junit4] 2> 13339 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 13340 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.SyncStrategy
https://127.0.0.1:46233/solr/addreplicatest_coll_shard2_replica_n2/ has no
replicas
[junit4] 2> 13339 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success -
now sync replicas to me
[junit4] 2> 13340 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:32805/solr/addreplicatest_coll_shard1_replica_n1/ has no
replicas
[junit4] 2> 13340 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
127.0.0.1:32805_solr synched 0
[junit4] 2> 13340 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext
127.0.0.1:46233_solr synched 0
[junit4] 2> 13340 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 13341 INFO (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext
Found all replicas participating in election, clear LIR
[junit4] 2> 13349 DEBUG (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase
Creating leader registration node
/collections/addreplicatest_coll/leaders/shard1/leader after winning as
/collections/addreplicatest_coll/leader_elect/shard1/election/99031224228904969-core_node3-n_0000000000
[junit4] 2> 13353 DEBUG (qtp856943761-88) [n:127.0.0.1:46233_solr
c:addreplicatest_coll s:shard2 r:core_node4
x:addreplicatest_coll_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase
Creating leader registration node
/collections/addreplicatest_coll/leaders/shard2/leader after winning as
/collections/addreplicatest_coll/leader_elect/shard2/election/99031224228904972-core_node4-n_0000000000
[junit4] 2> 13353 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
fired: children: /solr/overseer/queue
[junit4] 2> 13354 DEBUG (SyncThread:0) [ ] o.a.s.c.ZkTestServer Watch
added: children: /solr/overseer/queue
[junit4] 2> 13354 INFO (qtp2142237664-87) [n:127.0.0.1:32805_solr
c:addreplicatest_coll s:shard1 r:core_node3
x:addreplicatest_coll_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
https://127.0.0.1:32805/solr/addreplicatest_coll_shard1_replica_n1/ shard1
[junit4
[...truncated too long message...]
hard1_0_replica0] o.a.s.c.RecoveryStrategy Stopping recovery for
core=[shardSplitWithRule_shard1_0_replica0] coreNodeName=[core_node10]
[junit4] 2> 1655751 WARN
(updateExecutor-1187-thread-2-processing-n:127.0.0.1:42261_cvtw%2Fp
x:shardSplitWithRule_shard1_0_replica0 s:shard1_0 c:shardSplitWithRule
r:core_node10) [n:127.0.0.1:42261_cvtw%2Fp c:shardSplitWithRule s:shard1_0
r:core_node10 x:shardSplitWithRule_shard1_0_replica0]
o.a.s.u.DefaultSolrCoreState Skipping recovery because Solr is shutdown
[junit4] 2> 1655751 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.a.s.c.Overseer Overseer
(id=99031330072756242-127.0.0.1:42261_cvtw%2Fp-n_0000000004) closing
[junit4] 2> 1655751 INFO
(OverseerStateUpdate-99031330072756242-127.0.0.1:42261_cvtw%2Fp-n_0000000004)
[n:127.0.0.1:42261_cvtw%2Fp ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:42261_cvtw%2Fp
[junit4] 2> 1655751 WARN
(OverseerAutoScalingTriggerThread-99031330072756242-127.0.0.1:42261_cvtw%2Fp-n_0000000004)
[n:127.0.0.1:42261_cvtw%2Fp ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1655755 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@4b5f093e{HTTP/1.1,[http/1.1]}{127.0.0.1:۰}
[junit4] 2> 1655755 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@41c0eeef{/cvtw/p,null,UNAVAILABLE}
[junit4] 2> 1655756 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fd478529f0006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1655756 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.a.s.c.ChaosMonkey monkey: stop jetty! 35301
[junit4] 2> 1655756 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1655756 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[60CEE0CB6648DCBE]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:46239 46239
[junit4] 2> 1661633 INFO (Thread-1182) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:46239 46239
[junit4] 2> 1661633 WARN (Thread-1182) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 57 /solr/collections/shardSplitWithRule/state.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 7 /solr/clusterstate.json
[junit4] 2> 5 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 5 /solr/overseer/queue
[junit4] 2> 5 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 5 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_60CEE0CB6648DCBE-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{shard_s=Lucene50(blocksize=128), rnd_b=BlockTreeOrds(blocksize=128),
a_t=Lucene50(blocksize=128), id=BlockTreeOrds(blocksize=128)},
docValues:{shard_s=DocValuesFormat(name=Memory),
rnd_b=DocValuesFormat(name=Lucene70), _version_=DocValuesFormat(name=Memory),
n_ti=DocValuesFormat(name=Memory), a_t=DocValuesFormat(name=Memory),
a_i=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Lucene70)},
maxPointsInLeafNode=916, maxMBSortInHeap=5.469572387699129,
sim=RandomSimilarity(queryNorm=true): {}, locale=lrc-IR,
timezone=America/Indiana/Tell_City
[junit4] 2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1
(64-bit)/cpus=8,threads=1,free=219040880,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [SolrSlf4jReporterTest,
SolrIndexSplitterTest, AddReplicaTest, TestFieldCacheWithThreads,
HdfsCollectionsAPIDistributedZkTest, TestFastLRUCache,
DistributedVersionInfoTest, TestWriterPerf, RequestLoggingTest,
LegacyCloudClusterPropTest, NumericFieldsTest, MetricsConfigTest,
ShowFileRequestHandlerTest, HttpTriggerListenerTest, ZkStateReaderTest,
TestMultiValuedNumericRangeQuery, TestFaceting,
DistribDocExpirationUpdateProcessorTest, ZkSolrClientTest,
LeaderFailureAfterFreshStartTest, TestFieldCacheSort, TestDynamicLoading,
AutoAddReplicasIntegrationTest, AutoscalingHistoryHandlerTest,
SignatureUpdateProcessorFactoryTest, ManagedSchemaRoundRobinCloudTest,
DistributedFacetPivotLongTailTest, TestSortByMinMaxFunction,
TestCursorMarkWithoutUniqueKey, TestManagedSynonymFilterFactory,
TestManagedResource, CoreMergeIndexesAdminHandlerTest,
NotRequiredUniqueKeyTest, TestGeoJSONResponseWriter,
HdfsBasicDistributedZkTest, OverriddenZkACLAndCredentialsProvidersTest,
TestStressInPlaceUpdates, TestUseDocValuesAsStored, SolrCLIZkUtilsTest,
TestInitParams, TestBM25SimilarityFactory, TestReqParamsAPI,
TestScoreJoinQPScore, SampleTest, DistributedFacetPivotWhiteBoxTest,
TestPseudoReturnFields, TestAtomicUpdateErrorCases, CdcrBootstrapTest,
TestStressReorder, TestOverriddenPrefixQueryForCustomFieldType,
SearchRateTriggerTest, TestSolr4Spatial, TestJettySolrRunner,
SpatialRPTFieldTypeTest, SpellingQueryConverterTest, TestExceedMaxTermLength,
TestAnalyzedSuggestions, SolrGraphiteReporterTest, FullHLLTest,
OutputWriterTest, ConvertedLegacyTest, TestRangeQuery, TestCloudNestedDocsSort,
ShardSplitTest]
[junit4] Completed [387/749 (2!)] on J1 in 932.23s, 5 tests, 1 error <<<
FAILURES!
[...truncated 4107 lines...]
[junit4] Suite: org.apache.solr.analytics.NoFacetTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-analytics/test/J1/temp/solr.analytics.NoFacetTest_F6C89E26BB727660-001/init-core-data-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=292, maxMBSortInHeap=6.9858021103687085,
sim=RandomSimilarity(queryNorm=false): {}, locale=se-NO,
timezone=Australia/Melbourne
[junit4] 2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1
(64-bit)/cpus=8,threads=1,free=442045760,total=516947968
[junit4] 2> NOTE: All tests run in this JVM: [CastingFloatValueTest,
FloorFunctionTest, OrFunctionTest, SubtractFunctionTest,
CastingDoubleValueStreamTest, IfFunctionTest, CeilingFunctionTest, NoFacetTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=NoFacetTest
-Dtests.seed=F6C89E26BB727660 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=se-NO -Dtests.timezone=Australia/Melbourne -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | NoFacetTest (suite) <<<
[junit4] > Throwable #1:
org.apache.solr.client.solrj.SolrServerException:
org.apache.http.ParseException: Invalid content type:
[junit4] > at
__randomizedtesting.SeedInfo.seed([F6C89E26BB727660]:0)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:523)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1103)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
[junit4] > at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
[junit4] > at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
[junit4] > at
org.apache.solr.analytics.SolrAnalyticsTestCase.setupCollection(SolrAnalyticsTestCase.java:62)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] > Caused by: org.apache.http.ParseException: Invalid content
type:
[junit4] > at
org.apache.http.entity.ContentType.parse(ContentType.java:298)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:591)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
[junit4] > at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
[junit4] > ... 30 more
[junit4] Completed [23/78 (1!)] on J1 in 12.43s, 0 tests, 1 error <<<
FAILURES!
[...truncated 37225 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
