Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21455/
Java: 64bit/jdk-10-ea+42 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test
Error Message:
Could not find collection:collection2
Stack Trace:
java.lang.AssertionError: Could not find collection:collection2
at
__randomizedtesting.SeedInfo.seed([E98666FEF1703A34:61D259245F8C57CC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:140)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:915)
at
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:612)
at
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
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)
FAILED:
org.apache.solr.cloud.autoscaling.AutoAddReplicasPlanActionTest.testSimple
Error Message:
IOException occured when talking to server at: https://127.0.0.1:37249/solr
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when
talking to server at: https://127.0.0.1:37249/solr
at
__randomizedtesting.SeedInfo.seed([E98666FEF1703A34:D1354200D683EEE5]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657)
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:1104)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:884)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:817)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.autoscaling.AutoAddReplicasPlanActionTest.testSimple(AutoAddReplicasPlanActionTest.java:110)
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)
Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:37249 failed to
respond
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
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)
... 47 more
Build Log:
[...truncated 12889 lines...]
[junit4] Suite:
org.apache.solr.cloud.autoscaling.AutoAddReplicasPlanActionTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/init-core-data-001
[junit4] 2> 1045624 WARN
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1045624 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1045625 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1045625 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1045626 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001
[junit4] 2> 1045626 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1045626 INFO (Thread-5546) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1045626 INFO (Thread-5546) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1045628 ERROR (Thread-5546) [ ] 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> 1045726 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:44211
[junit4] 2> 1045728 INFO (zkConnectionManagerCallback-1463-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045730 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T14:27:37-07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1045730 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T14:27:37-07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1045730 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T14:27:37-07:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@250647ba{/solr,null,AVAILABLE}
[junit4] 2> 1045731 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@45fd61db{/solr,null,AVAILABLE}
[junit4] 2> 1045732 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@18f98ea{/solr,null,AVAILABLE}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@38305393{SSL,[ssl,
http/1.1]}{127.0.0.1:37747}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2fa720bb{SSL,[ssl,
http/1.1]}{127.0.0.1:37249}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.e.j.s.Server Started @1047802ms
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.e.j.s.Server Started @1047802ms
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@6e43c4ff{SSL,[ssl,
http/1.1]}{127.0.0.1:45867}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37747}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-2) [ ]
o.e.j.s.Server Started @1047802ms
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37249}
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45867}
[junit4] 2> 1045733 ERROR (jetty-launcher-1460-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1045733 ERROR (jetty-launcher-1460-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1045733 ERROR (jetty-launcher-1460-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-14T07:14:33.472776Z
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-14T07:14:33.472835Z
[junit4] 2> 1045733 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1045734 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1045734 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-14T07:14:33.473157Z
[junit4] 2> 1045735 INFO (zkConnectionManagerCallback-1466-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045735 INFO (zkConnectionManagerCallback-1469-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045735 INFO (zkConnectionManagerCallback-1467-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045735 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1045735 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1045735 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1045738 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10050cd548c0002, likely client has closed socket
[junit4] 2> 1045739 INFO (jetty-launcher-1460-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44211/solr
[junit4] 2> 1045740 INFO (jetty-launcher-1460-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44211/solr
[junit4] 2> 1045741 INFO (jetty-launcher-1460-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44211/solr
[junit4] 2> 1045741 INFO (zkConnectionManagerCallback-1474-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045741 INFO (zkConnectionManagerCallback-1478-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045742 INFO (zkConnectionManagerCallback-1481-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045742 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10050cd548c0005, likely client has closed socket
[junit4] 2> 1045743 INFO
(zkConnectionManagerCallback-1483-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045743 INFO
(zkConnectionManagerCallback-1485-thread-1-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045743 INFO
(zkConnectionManagerCallback-1487-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045789 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1045790 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37249_solr
[junit4] 2> 1045790 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.c.Overseer Overseer
(id=72146436854906888-127.0.0.1:37249_solr-n_0000000000) starting
[junit4] 2> 1045791 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1045791 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1045791 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45867_solr
[junit4] 2> 1045791 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37747_solr
[junit4] 2> 1045796 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1045796 INFO
(zkCallback-1484-thread-1-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1045796 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1045799 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37249_solr
[junit4] 2> 1045803 INFO
(zkCallback-1484-thread-1-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1045803 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1045804 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1045831 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45867.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045834 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045836 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45867.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045837 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45867.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045837 INFO (jetty-launcher-1460-thread-2)
[n:127.0.0.1:45867_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node2/.
[junit4] 2> 1045841 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045842 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045842 INFO (jetty-launcher-1460-thread-1)
[n:127.0.0.1:37249_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/.
[junit4] 2> 1045873 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37747.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045882 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37747.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045882 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37747.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1045883 INFO (jetty-launcher-1460-thread-3)
[n:127.0.0.1:37747_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node3/.
[junit4] 2> 1045913 INFO (zkConnectionManagerCallback-1495-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045914 INFO (zkConnectionManagerCallback-1499-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1045915 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1045915 INFO
(SUITE-AutoAddReplicasPlanActionTest-seed#[E98666FEF1703A34]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44211/solr ready
[junit4] 2> 1045927 INFO
(TEST-AutoAddReplicasPlanActionTest.testSimple-seed#[E98666FEF1703A34]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSimple
[junit4] 2> 1045942 INFO (qtp1568421645-11761) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=true&name=testSimple1&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:45867_solr,127.0.0.1:37249_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1045943 INFO
(OverseerThreadFactory-2889-thread-1-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testSimple1
[junit4] 2> 1046048 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSimple1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45867/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1046048 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSimple1_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37249/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1046049 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testSimple1_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45867/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1046050 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testSimple1_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37249/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1046286 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1046286 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1046286 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1046286 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1046287 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1046291 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1046393 INFO
(zkCallback-1484-thread-1-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1046393 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1046393 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1047292 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1047292 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1047312 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.s.IndexSchema [testSimple1_shard1_replica_n2] Schema name=minimal
[junit4] 2> 1047313 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1047313 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard1_replica_n2' using
configuration from collection testSimple1, trusted=true
[junit4] 2> 1047314 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.core.testSimple1.shard1.replica_n2' (registry
'solr.core.testSimple1.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1047314 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1047314 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.c.SolrCore [[testSimple1_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/testSimple1_shard1_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/./testSimple1_shard1_replica_n2/data/]
[junit4] 2> 1047315 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1047315 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1047318 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.s.IndexSchema [testSimple1_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1047319 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1047319 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard1_replica_n1' using
configuration from collection testSimple1, trusted=true
[junit4] 2> 1047319 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.s.IndexSchema [testSimple1_shard2_replica_n6] Schema name=minimal
[junit4] 2> 1047319 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.s.IndexSchema [testSimple1_shard2_replica_n4] Schema name=minimal
[junit4] 2> 1047319 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45867.solr.core.testSimple1.shard1.replica_n1' (registry
'solr.core.testSimple1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1047319 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1047319 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.SolrCore [[testSimple1_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node2/testSimple1_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node2/./testSimple1_shard1_replica_n1/data/]
[junit4] 2> 1047320 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1047320 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1047320 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard2_replica_n6' using
configuration from collection testSimple1, trusted=true
[junit4] 2> 1047320 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple1_shard2_replica_n4' using
configuration from collection testSimple1, trusted=true
[junit4] 2> 1047321 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45867.solr.core.testSimple1.shard2.replica_n4' (registry
'solr.core.testSimple1.shard2.replica_n4') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1047321 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1047321 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.SolrCore [[testSimple1_shard2_replica_n4] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node2/testSimple1_shard2_replica_n4],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node2/./testSimple1_shard2_replica_n4/data/]
[junit4] 2> 1047322 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.core.testSimple1.shard2.replica_n6' (registry
'solr.core.testSimple1.shard2.replica_n6') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1047322 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1047322 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.c.SolrCore [[testSimple1_shard2_replica_n6] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/testSimple1_shard2_replica_n6],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/./testSimple1_shard2_replica_n6/data/]
[junit4] 2> 1047409 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1047409 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1047411 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1047411 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1047412 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1047412 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1047415 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1047415 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1047419 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@35ad2568[testSimple1_shard1_replica_n1] main]
[junit4] 2> 1047420 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1047420 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1047421 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@27a1ed4c[testSimple1_shard2_replica_n4] main]
[junit4] 2> 1047421 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1047422 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1047422 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1047423 INFO
(searcherExecutor-2897-thread-1-processing-n:127.0.0.1:45867_solr
x:testSimple1_shard1_replica_n1 s:shard1 c:testSimple1 r:core_node3)
[n:127.0.0.1:45867_solr c:testSimple1 s:shard1 r:core_node3
x:testSimple1_shard1_replica_n1] o.a.s.c.SolrCore
[testSimple1_shard1_replica_n1] Registered new searcher
Searcher@35ad2568[testSimple1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1047423 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359623235469312
[junit4] 2> 1047426 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1047426 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1047426 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1047427 INFO
(searcherExecutor-2899-thread-1-processing-n:127.0.0.1:45867_solr
x:testSimple1_shard2_replica_n4 s:shard2 c:testSimple1 r:core_node7)
[n:127.0.0.1:45867_solr c:testSimple1 s:shard2 r:core_node7
x:testSimple1_shard2_replica_n4] o.a.s.c.SolrCore
[testSimple1_shard2_replica_n4] Registered new searcher
Searcher@27a1ed4c[testSimple1_shard2_replica_n4]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1047427 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359623239663616
[junit4] 2> 1047427 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1047428 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1047429 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@f942873[testSimple1_shard1_replica_n2] main]
[junit4] 2> 1047430 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1047430 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1047430 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1047430 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1047431 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1047431 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1047431 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1047431 INFO
(searcherExecutor-2896-thread-1-processing-n:127.0.0.1:37249_solr
x:testSimple1_shard1_replica_n2 s:shard1 c:testSimple1 r:core_node5)
[n:127.0.0.1:37249_solr c:testSimple1 s:shard1 r:core_node5
x:testSimple1_shard1_replica_n2] o.a.s.c.SolrCore
[testSimple1_shard1_replica_n2] Registered new searcher
Searcher@f942873[testSimple1_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1047432 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359623244906496
[junit4] 2> 1047433 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@778e24d2[testSimple1_shard2_replica_n6] main]
[junit4] 2> 1047434 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1047436 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1047436 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1047437 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1047438 INFO
(searcherExecutor-2898-thread-1-processing-n:127.0.0.1:37249_solr
x:testSimple1_shard2_replica_n6 s:shard2 c:testSimple1 r:core_node8)
[n:127.0.0.1:37249_solr c:testSimple1 s:shard2 r:core_node8
x:testSimple1_shard2_replica_n6] o.a.s.c.SolrCore
[testSimple1_shard2_replica_n6] Registered new searcher
Searcher@778e24d2[testSimple1_shard2_replica_n6]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1047438 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359623251197952
[junit4] 2> 1047439 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 1047937 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1047937 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1047937 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45867/solr/testSimple1_shard2_replica_n4/
[junit4] 2> 1047937 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.PeerSync PeerSync: core=testSimple1_shard2_replica_n4
url=https://127.0.0.1:45867/solr START
replicas=[https://127.0.0.1:37249/solr/testSimple1_shard2_replica_n6/]
nUpdates=100
[junit4] 2> 1047939 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1047939 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1047939 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45867/solr/testSimple1_shard1_replica_n1/
[junit4] 2> 1047940 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.PeerSync PeerSync: core=testSimple1_shard1_replica_n1
url=https://127.0.0.1:45867/solr START
replicas=[https://127.0.0.1:37249/solr/testSimple1_shard1_replica_n2/]
nUpdates=100
[junit4] 2> 1047940 INFO (qtp585562653-11836) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.c.S.Request [testSimple1_shard2_replica_n6] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1047943 INFO (qtp585562653-11836) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.c.S.Request [testSimple1_shard1_replica_n2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1048238 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.u.PeerSync PeerSync: core=testSimple1_shard2_replica_n4
url=https://127.0.0.1:45867/solr DONE. We have no versions. sync failed.
[junit4] 2> 1048238 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1048238 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1048238 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1048240 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45867/solr/testSimple1_shard2_replica_n4/ shard2
[junit4] 2> 1048240 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.u.PeerSync PeerSync: core=testSimple1_shard1_replica_n1
url=https://127.0.0.1:45867/solr DONE. We have no versions. sync failed.
[junit4] 2> 1048241 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1048241 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1048241 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1048247 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45867/solr/testSimple1_shard1_replica_n1/ shard1
[junit4] 2> 1049395 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049395 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049395 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049496 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049496 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049496 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049499 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1049500 INFO (qtp1228262005-11837) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard1 r:core_node3 x:testSimple1_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n1&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3214
[junit4] 2> 1049542 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1049543 INFO (qtp1228262005-11755) [n:127.0.0.1:45867_solr
c:testSimple1 s:shard2 r:core_node7 x:testSimple1_shard2_replica_n4]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n4&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3257
[junit4] 2> 1049546 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard1 r:core_node5 x:testSimple1_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testSimple1_shard1_replica_n2&action=CREATE&numShards=2&collection=testSimple1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3260
[junit4] 2> 1049550 INFO (qtp585562653-11759) [n:127.0.0.1:37249_solr
c:testSimple1 s:shard2 r:core_node8 x:testSimple1_shard2_replica_n6]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testSimple1_shard2_replica_n6&action=CREATE&numShards=2&collection=testSimple1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=3258
[junit4] 2> 1049552 INFO (qtp1568421645-11761) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1049646 INFO
(zkCallback-1486-thread-1-processing-n:127.0.0.1:45867_solr)
[n:127.0.0.1:45867_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049646 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049646 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple1/state.json] for collection [testSimple1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1049944 INFO
(OverseerCollectionConfigSetProcessor-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1050552 INFO (qtp1568421645-11761) [n:127.0.0.1:37747_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=2&autoAddReplicas=true&name=testSimple1&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=127.0.0.1:45867_solr,127.0.0.1:37249_solr&wt=javabin&version=2}
status=0 QTime=4610
[junit4] 2> 1050553 INFO (qtp1568421645-11763) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&autoAddReplicas=false&name=testSimple2&nrtReplicas=2&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37249_solr,127.0.0.1:37747_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1050555 INFO
(OverseerThreadFactory-2889-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testSimple2
[junit4] 2> 1050759 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSimple2_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37249/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1050760 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSimple2_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37747/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1050961 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n1&action=CREATE&numShards=1&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1050963 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n2&action=CREATE&numShards=1&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1050963 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1051065 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1051065 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1051065 INFO
(zkCallback-1482-thread-2-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1051065 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1051967 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1051968 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1051971 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.s.IndexSchema [testSimple2_shard1_replica_n1] Schema name=minimal
[junit4] 2> 1051972 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.s.IndexSchema [testSimple2_shard1_replica_n2] Schema name=minimal
[junit4] 2> 1051973 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1051973 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 1051973 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard1_replica_n2' using
configuration from collection testSimple2, trusted=true
[junit4] 2> 1051973 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'testSimple2_shard1_replica_n1' using
configuration from collection testSimple2, trusted=true
[junit4] 2> 1051973 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37249.solr.core.testSimple2.shard1.replica_n1' (registry
'solr.core.testSimple2.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1051973 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1051973 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.c.SolrCore [[testSimple2_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/testSimple2_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node1/./testSimple2_shard1_replica_n1/data/]
[junit4] 2> 1051975 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37747.solr.core.testSimple2.shard1.replica_n2' (registry
'solr.core.testSimple2.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15ca468b
[junit4] 2> 1051975 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1051975 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.SolrCore [[testSimple2_shard1_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node3/testSimple2_shard1_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.AutoAddReplicasPlanActionTest_E98666FEF1703A34-001/tempDir-001/node3/./testSimple2_shard1_replica_n2/data/]
[junit4] 2> 1052034 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1052034 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1052034 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1052034 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1052034 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1052035 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1052035 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1052035 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1052035 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@1034ea02[testSimple2_shard1_replica_n1] main]
[junit4] 2> 1052036 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1052036 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@719f5c97[testSimple2_shard1_replica_n2] main]
[junit4] 2> 1052036 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1052036 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 1052036 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1052037 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 1052037 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359628073598976
[junit4] 2> 1052037 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1052038 INFO
(searcherExecutor-2916-thread-1-processing-n:127.0.0.1:37747_solr
x:testSimple2_shard1_replica_n2 s:shard1 c:testSimple2 r:core_node4)
[n:127.0.0.1:37747_solr c:testSimple2 s:shard1 r:core_node4
x:testSimple2_shard1_replica_n2] o.a.s.c.SolrCore
[testSimple2_shard1_replica_n2] Registered new searcher
Searcher@719f5c97[testSimple2_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1052038 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1592359628074647552
[junit4] 2> 1052039 INFO
(searcherExecutor-2917-thread-1-processing-n:127.0.0.1:37249_solr
x:testSimple2_shard1_replica_n1 s:shard1 c:testSimple2 r:core_node3)
[n:127.0.0.1:37249_solr c:testSimple2 s:shard1 r:core_node3
x:testSimple2_shard1_replica_n1] o.a.s.c.SolrCore
[testSimple2_shard1_replica_n1] Registered new searcher
Searcher@1034ea02[testSimple2_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1052041 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1052041 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1052041 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:37747/solr/testSimple2_shard1_replica_n2/
[junit4] 2> 1052041 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=testSimple2_shard1_replica_n2
url=https://127.0.0.1:37747/solr START
replicas=[https://127.0.0.1:37249/solr/testSimple2_shard1_replica_n1/]
nUpdates=100
[junit4] 2> 1052044 INFO (qtp585562653-11753) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.c.S.Request [testSimple2_shard1_replica_n1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 1052142 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052142 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052142 INFO
(zkCallback-1482-thread-2-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052142 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052342 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.u.PeerSync PeerSync: core=testSimple2_shard1_replica_n2
url=https://127.0.0.1:37747/solr DONE. We have no versions. sync failed.
[junit4] 2> 1052342 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 1052342 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 1052342 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1052344 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:37747/solr/testSimple2_shard1_replica_n2/ shard1
[junit4] 2> 1052445 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052445 INFO
(zkCallback-1482-thread-2-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052445 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052445 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052495 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1052597 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052597 INFO
(zkCallback-1482-thread-2-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052597 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1052597 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1053143 INFO
(zkCallback-1482-thread-2-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1053143 INFO
(zkCallback-1484-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1053143 INFO
(zkCallback-1484-thread-2-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1053143 INFO
(zkCallback-1482-thread-1-processing-n:127.0.0.1:37747_solr)
[n:127.0.0.1:37747_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/testSimple2/state.json] for collection [testSimple2] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1053222 INFO (qtp1568421645-11762) [n:127.0.0.1:37747_solr
c:testSimple2 s:shard1 r:core_node4 x:testSimple2_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n2&action=CREATE&numShards=1&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2259
[junit4] 2> 1053222 INFO (qtp585562653-11833) [n:127.0.0.1:37249_solr
c:testSimple2 s:shard1 r:core_node3 x:testSimple2_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testSimple2_shard1_replica_n1&action=CREATE&numShards=1&collection=testSimple2&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2260
[junit4] 2> 1053223 INFO (qtp1568421645-11763) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1053223 INFO (qtp1568421645-11763) [n:127.0.0.1:37747_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&autoAddReplicas=false&name=testSimple2&nrtReplicas=2&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37249_solr,127.0.0.1:37747_solr&wt=javabin&version=2}
status=0 QTime=2670
[junit4] 2> 1053224 INFO (qtp1568421645-11761) [n:127.0.0.1:37747_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&maxShardsPerNode=3&autoAddReplicas=false&name=testSimple3&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=127.0.0.1:45867_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1053225 INFO
(OverseerThreadFactory-2889-thread-3-processing-n:127.0.0.1:37249_solr)
[n:127.0.0.1:37249_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
testSimple3
[junit4] 2> 1053225 INFO
(OverseerCollectionConfigSetProcessor-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1053429 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSimple3",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSimple3_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45867/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1053430 INFO
(OverseerStateUpdate-72146436854906888-127.0.0.1:37249_solr-n_0000000000)
[n:127.0.0.1:37249_solr ] o.a.s.c.o.SliceM
[...truncated too long message...]
ngPostingsFormat(Lucene50(blocksize=128))),
7grand1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
15parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
25parent_f2_s=PostingsFormat(name=LuceneFixedGap),
6parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
0parent_f2_s=PostingsFormat(name=Direct),
3grand1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
19parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
4parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
9parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
a_t=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=Direct),
5grand3_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
1parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
13parent_f1_s=PostingsFormat(name=LuceneFixedGap),
23parent_f1_s=PostingsFormat(name=Direct),
_root_=PostingsFormat(name=LuceneFixedGap),
29parent_f1_s=PostingsFormat(name=Direct),
3child0_s=PostingsFormat(name=LuceneVarGapFixedInterval),
4child3_s=PostingsFormat(name=LuceneVarGapFixedInterval),
12parent_f1_s=PostingsFormat(name=Direct),
22parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
1grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval),
7parent_f1_s=PostingsFormat(name=Direct),
2child1_s=PostingsFormat(name=Direct),
3parent_f2_s=PostingsFormat(name=LuceneFixedGap),
32parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
6grand3_s=PostingsFormat(name=LuceneVarGapFixedInterval),
31parent_f2_s=PostingsFormat(name=Direct),
5grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
11parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
21parent_f2_s=PostingsFormat(name=LuceneFixedGap),
4grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
7grand4_s=PostingsFormat(name=LuceneVarGapFixedInterval),
3grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval),
9parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
30parent_f1_s=PostingsFormat(name=Direct),
14parent_f2_s=PostingsFormat(name=LuceneFixedGap),
20parent_f1_s=PostingsFormat(name=LuceneFixedGap),
1parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
7grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval),
text_t=PostingsFormat(name=LuceneFixedGap),
24parent_f2_s=PostingsFormat(name=Direct),
13parent_f2_s=PostingsFormat(name=Direct),
type_s=PostingsFormat(name=LuceneFixedGap),
23parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
10parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
22parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
4child0_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
12parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
32parent_f2_s=PostingsFormat(name=LuceneFixedGap),
31parent_f1_s=PostingsFormat(name=LuceneFixedGap),
5grand1_s=PostingsFormat(name=LuceneFixedGap),
6grand4_s=PostingsFormat(name=LuceneFixedGap),
11parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
21parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
4grand2_s=PostingsFormat(name=LuceneFixedGap),
7grand3_s=PostingsFormat(name=LuceneFixedGap),
14parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
20parent_f2_s=PostingsFormat(name=Direct),
24parent_f1_s=PostingsFormat(name=LuceneFixedGap),
30parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
5parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
6grand0_s=PostingsFormat(name=LuceneFixedGap),
10parent_f2_s=PostingsFormat(name=LuceneFixedGap),
8parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
27parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
2parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
4child1_s=PostingsFormat(name=Direct),
2grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
17parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
3child2_s=PostingsFormat(name=Direct),
16parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
26parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
1child0_s=PostingsFormat(name=Direct), 7grand6_s=PostingsFormat(name=Direct),
18parent_f1_s=PostingsFormat(name=Direct),
5grand0_s=PostingsFormat(name=Direct),
28parent_f1_s=PostingsFormat(name=LuceneFixedGap),
6grand5_s=PostingsFormat(name=Direct), 7grand2_s=PostingsFormat(name=Direct),
15parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
4grand3_s=PostingsFormat(name=Direct),
6parent_f1_s=PostingsFormat(name=LuceneFixedGap),
25parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
0parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
3grand2_s=PostingsFormat(name=Direct),
19parent_f2_s=PostingsFormat(name=Direct),
4parent_f2_s=PostingsFormat(name=Direct),
5grand4_s=PostingsFormat(name=Direct), 6grand1_s=PostingsFormat(name=Direct),
5parent_f2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
16parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval),
8parent_f2_s=PostingsFormat(name=Direct),
29parent_f2_s=PostingsFormat(name=LuceneFixedGap),
2parent_f1_s=PostingsFormat(name=LuceneFixedGap),
4child2_s=PostingsFormat(name=LuceneFixedGap),
rnd_b=PostingsFormat(name=Direct), 27parent_f1_s=PostingsFormat(name=Direct),
17parent_f1_s=PostingsFormat(name=LuceneFixedGap),
2grand0_s=PostingsFormat(name=LuceneFixedGap),
3child1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
7parent_f2_s=PostingsFormat(name=LuceneFixedGap),
26parent_f1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
2child0_s=PostingsFormat(name=LuceneFixedGap),
3parent_f1_s=PostingsFormat(name=Direct)},
docValues:{_version_=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1476,
maxMBSortInHeap=5.089345844014558,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3c5a05af),
locale=en-PR, timezone=Europe/Ljubljana
[junit4] 2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation 10-ea
(64-bit)/cpus=8,threads=1,free=196108800,total=502792192
[junit4] 2> NOTE: All tests run in this JVM: [TestDynamicFieldResource,
CoreAdminCreateDiscoverTest, ManagedSchemaRoundRobinCloudTest, BasicZkTest,
HdfsThreadLeakTest, RuleEngineTest, SyncSliceTest, TestBlobHandler,
CollectionReloadTest, ZkStateReaderTest, TestSizeLimitedDistributedMap,
TestStressVersions, TestTrackingShardHandlerFactory, TestFoldingMultitermQuery,
TestTriggerIntegration, TestGenericDistributedQueue, TestCloudManagedSchema,
CollectionStateFormat2Test, TestCharFilters, TestManagedSynonymFilterFactory,
DocumentBuilderTest, NodeLostTriggerTest, FileUtilsTest,
TestScoreJoinQPNoScore, TestTolerantUpdateProcessorCloud,
TestReplicationHandler, AtomicUpdatesTest, CdcrBootstrapTest,
AsyncCallRequestStatusResponseTest, ConfigSetsAPITest, ShardRoutingCustomTest,
SuggesterTest, BooleanFieldTest, TestXmlQParser, SystemInfoHandlerTest,
DistanceUnitsTest, RegexBytesRefFilterTest, TestShardHandlerFactory,
HdfsWriteToMultipleCollectionsTest, GraphQueryTest, AlternateDirectoryTest,
SolrSlf4jReporterTest, TestConfigSetsAPI, TestInitQParser, TestPolicyCloud,
TestSolrJ, TestSolr4Spatial2, TestIntervalFaceting, TestSearcherReuse,
TestFunctionQuery, FastVectorHighlighterTest, TestPerFieldSimilarity,
PolyFieldTest, ComputePlanActionTest, TestRecovery,
TestSha256AuthenticationProvider, TestMacros, MergeStrategyTest,
TestFastLRUCache, TestLocalFSCloudBackupRestore, TestNodeLostTrigger,
TestStressInPlaceUpdates, SecurityConfHandlerTest, PrimitiveFieldTypeTest,
SOLR749Test, SampleTest, TimeRoutedAliasUpdateProcessorTest,
CSVRequestHandlerTest, CoreSorterTest, TestRestoreCore, SortByFunctionTest,
BlockDirectoryTest, QueryEqualityTest, TestStressRecovery, TestDynamicLoading,
SimplePostToolTest, DistributedIntervalFacetingTest,
HdfsCollectionsAPIDistributedZkTest, LeaderInitiatedRecoveryOnShardRestartTest,
ClassificationUpdateProcessorTest, QueryElevationComponentTest,
TestFieldCacheReopen, DistributedMLTComponentTest, ChaosMonkeySafeLeaderTest,
PathHierarchyTokenizerFactoryTest, DocValuesNotIndexedTest,
TestSimpleTrackingShardHandler, SignatureUpdateProcessorFactoryTest,
HdfsLockFactoryTest, TestCloudRecovery, TestQueryWrapperFilter,
TestSchemalessBufferedUpdates, TestPartialUpdateDeduplication,
TestComplexPhraseQParserPlugin, TestRetrieveFieldsOptimizer,
SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest,
TestJettySolrRunner, TestExpandComponent, SuggesterFSTTest,
TestReRankQParserPlugin, TestGeoJSONResponseWriter,
UpdateRequestProcessorFactoryTest, CloudMLTQParserTest,
TestExactSharedStatsCache, BadComponentTest, SolrGraphiteReporterTest,
CreateRoutedAliasTest, DeleteNodeTest, TestTrie, TestInitParams,
TestCloudJSONFacetJoinDomain, TestSerializedLuceneMatchVersion,
TestHdfsBackupRestoreCore, TermsComponentTest, DistributedSuggestComponentTest,
MissingSegmentRecoveryTest, TestQueryUtils, DateRangeFieldTest,
HdfsDirectoryFactoryTest, TestSubQueryTransformer, LoggingHandlerTest,
OverseerTaskQueueTest, WrapperMergePolicyFactoryTest, DOMUtilTest,
TestRandomRequestDistribution, HdfsChaosMonkeySafeLeaderTest,
BasicDistributedZk2Test, UnloadDistributedZkTest, OpenCloseCoreStressTest,
OverseerTest, ShardRoutingTest, FullSolrCloudDistribCmdsTest]
[junit4] Completed [341/776 (2!)] on J1 in 59.64s, 1 test, 1 failure <<<
FAILURES!
[...truncated 42688 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
