Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21201/
Java: 64bit/jdk-10-ea+37 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test
Error Message:
Stack Trace:
java.util.concurrent.TimeoutException
at
__randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0)
at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1261)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:449)
at
org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test(TestLeaderElectionWithEmptyReplica.java:97)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.schema.TestCloudSchemaless.test
Error Message:
Timeout occured while waiting response from server at:
http://127.0.0.1:34559/bix
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:34559/bix
at
__randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:654)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java: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.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:320)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:991)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:171)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:141)
at
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
... 42 more
Build Log:
[...truncated 13486 lines...]
[junit4] Suite: org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica
[junit4] 2> 2486131 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/init-core-data-001
[junit4] 2> 2486131 WARN
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=28 numCloses=28
[junit4] 2> 2486131 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2486132 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 2486133 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001
[junit4] 2> 2486133 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2486133 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2486133 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2486134 ERROR (Thread-6134) [ ] 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> 2486233 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:39971
[junit4] 2> 2486235 INFO (zkConnectionManagerCallback-4322-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486237 INFO (jetty-launcher-4319-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2486237 INFO (jetty-launcher-4319-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1c9a2646{/solr,null,AVAILABLE}
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@380217f8{/solr,null,AVAILABLE}
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7118407c{SSL,[ssl,
http/1.1]}{127.0.0.1:44563}
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@df2e422{SSL,[ssl,
http/1.1]}{127.0.0.1:33333}
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-1) [ ]
o.e.j.s.Server Started @2488155ms
[junit4] 2> 2486239 INFO (jetty-launcher-4319-thread-2) [ ]
o.e.j.s.Server Started @2488155ms
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=44563}
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=33333}
[junit4] 2> 2486240 ERROR (jetty-launcher-4319-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2486240 ERROR (jetty-launcher-4319-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-03T00:36:13.475436Z
[junit4] 2> 2486240 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-03T00:36:13.475475Z
[junit4] 2> 2486241 INFO (zkConnectionManagerCallback-4326-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486241 INFO (zkConnectionManagerCallback-4325-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486241 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2486241 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2486247 INFO (jetty-launcher-4319-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 2486248 INFO (zkConnectionManagerCallback-4330-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486249 INFO (jetty-launcher-4319-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 2486249 INFO
(zkConnectionManagerCallback-4334-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486249 INFO (zkConnectionManagerCallback-4336-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486250 INFO
(zkConnectionManagerCallback-4338-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486284 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2486284 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:44563_solr
[junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer
(id=99283092987510790-127.0.0.1:44563_solr-n_0000000000) starting
[junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2486285 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33333_solr
[junit4] 2> 2486289 INFO
(zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2486289 INFO
(zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2486294 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:44563_solr
[junit4] 2> 2486294 INFO
(zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2486297 INFO
(zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2486380 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486389 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486390 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486391 INFO (jetty-launcher-4319-thread-2)
[n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/.
[junit4] 2> 2486391 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44563.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486399 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44563.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486400 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_44563.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2486401 INFO (jetty-launcher-4319-thread-1)
[n:127.0.0.1:44563_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node1/.
[junit4] 2> 2486544 INFO (zkConnectionManagerCallback-4344-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486546 INFO (zkConnectionManagerCallback-4348-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2486546 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2486547 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39971/solr ready
[junit4] 2> 2486559 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&replicationFactor=1&collection.configName=config&name=solr_9504&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2486560 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&replicationFactor=1&collection.configName=config&name=solr_9504&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2486560 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2486561 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2486561 INFO
(OverseerThreadFactory-7887-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.CreateCollectionCmd Create collection
solr_9504
[junit4] 2> 2486664 INFO
(OverseerStateUpdate-99283092987510790-127.0.0.1:44563_solr-n_0000000000)
[n:127.0.0.1:44563_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"solr_9504",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"solr_9504_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:33333/solr";,
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2486867 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=config&newCollection=true&collection=solr_9504&version=2&replicaType=NRT&async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&coreNodeName=core_node2&name=solr_9504_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin}
status=0 QTime=0
[junit4] 2> 2486867 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=config&newCollection=true&collection=solr_9504&version=2&replicaType=NRT&async=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&coreNodeName=core_node2&name=solr_9504_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin
[junit4] 2> 2486867 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2486867 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CoreAdminOperation Checking request status for :
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698
[junit4] 2> 2486867 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2486969 INFO
(zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2486969 INFO
(zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2487562 INFO (qtp470993904-22573) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2487562 INFO (qtp470993904-22573) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2487868 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CoreAdminOperation Checking request status for :
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698
[junit4] 2> 2487868 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2487872 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.0.0
[junit4] 2> 2487876 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema
[solr_9504_shard1_replica_n1] Schema name=minimal
[junit4] 2> 2487877 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 2487877 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore
'solr_9504_shard1_replica_n1' using configuration from collection solr_9504,
trusted=true
[junit4] 2> 2487877 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.core.solr_9504.shard1.replica_n1' (registry
'solr.core.solr_9504.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2487877 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2487877 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [[solr_9504_shard1_replica_n1]
] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/solr_9504_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/./solr_9504_shard1_replica_n1/data/]
[junit4] 2> 2487965 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2487965 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2487966 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2487966 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2487967 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@20507dce[solr_9504_shard1_replica_n1] main]
[junit4] 2> 2487968 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 2487968 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 2487968 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2487969 INFO
(searcherExecutor-7892-thread-1-processing-x:solr_9504_shard1_replica_n1
r:core_node2 16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE
n:127.0.0.1:33333_solr s:shard1 c:solr_9504) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.c.SolrCore [solr_9504_shard1_replica_n1] Registered new searcher
Searcher@20507dce[solr_9504_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2487969 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in
index or recent updates, using new clock 1588529489724309504
[junit4] 2> 2487971 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2487971 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the
new leader - try and sync
[junit4] 2> 2487971 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/
[junit4] 2> 2487971 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2487972 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ has no replicas
[junit4] 2> 2487972 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 2487973 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ shard1
[junit4] 2> 2488074 INFO
(zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2488074 INFO
(zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2488123 INFO
(parallelCoreAdminExecutor-7888-thread-1-processing-n:127.0.0.1:33333_solr
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698 CREATE)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2488225 INFO
(zkCallback-4333-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2488225 INFO
(zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/solr_9504/state.json] for collection [solr_9504] has occurred
- updating... (live nodes size: [2])
[junit4] 2> 2488563 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2488564 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2488868 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CoreAdminOperation Checking request status for :
16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698
[junit4] 2> 2488869 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b02640915871312698&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2488870 INFO
(OverseerThreadFactory-7887-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_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> 2489564 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with
params
requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2489565 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=REQUESTSTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2489565 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with
params
requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=DELETESTATUS&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2489565 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={requestid=16a1e0b9-4a44-4ab9-9a7e-60d05866b5b0&action=DELETESTATUS&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2489572 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 2489574 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[0 (1588529491406225408)]} 0 0
[junit4] 2> 2489575 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[1 (1588529491408322560)]} 0 0
[junit4] 2> 2489576 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[2 (1588529491409371136)]} 0 0
[junit4] 2> 2489578 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[3 (1588529491411468288)]} 0 0
[junit4] 2> 2489579 INFO (qtp470993904-22574) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[4 (1588529491412516864)]} 0 0
[junit4] 2> 2489579 INFO (qtp470993904-22571) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[5 (1588529491412516865)]} 0 0
[junit4] 2> 2489580 INFO (qtp470993904-22565) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[6 (1588529491413565440)]} 0 0
[junit4] 2> 2489580 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[7 (1588529491413565441)]} 0 0
[junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[8 (1588529491413565442)]} 0 0
[junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update params={wt=javabin&version=2}{add=[9 (1588529491414614016)]} 0 0
[junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1588529491414614017,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2489581 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3aafc2f3
commitCommandVersion:1588529491414614017
[junit4] 2> 2489660 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@610efca5[solr_9504_shard1_replica_n1] main]
[junit4] 2> 2489660 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2489661 INFO
(searcherExecutor-7892-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1]
Registered new searcher Searcher@610efca5[solr_9504_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)))}
[junit4] 2> 2489662 INFO (qtp470993904-22563) [n:127.0.0.1:33333_solr
c:solr_9504 s:shard1 r:core_node2 x:solr_9504_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [solr_9504_shard1_replica_n1] webapp=/solr
path=/update
params={_stateVer_=solr_9504:4&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 80
[junit4] 2> 2489662 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ChaosMonkey monkey: kill jetty! 33333
[junit4] 2> 2489663 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@df2e422{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2489663 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=426980389
[junit4] 2> 2489663 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2489663 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@caaedd2: rootName =
solr_33333, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@fbbb095
[junit4] 2> 2489671 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2489671 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6803b07c: rootName =
solr_33333, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a
[junit4] 2> 2489676 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2489676 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@70f6d734: rootName =
solr_33333, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0
[junit4] 2> 2489677 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:33333_solr
[junit4] 2> 2489677 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2489677 INFO
(zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 2489677 INFO (zkCallback-4347-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2489677 INFO
(zkCallback-4333-thread-2-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1]
CLOSING SolrCore org.apache.solr.core.SolrCore@fced1ef
[junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.solr_9504.shard1.replica_n1, tag=265212399
[junit4] 2> 2489677 INFO (coreCloseExecutor-7897-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@16ef28a2: rootName =
solr_33333, domain = solr.core.solr_9504.shard1.replica_n1, service url = null,
agent id = null] for registry solr.core.solr_9504.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@40a666d2
[junit4] 2> 2489686 INFO (coreCloseExecutor-7897-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.solr_9504.shard1.leader, tag=265212399
[junit4] 2> 2489689 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@380217f8{/solr,null,UNAVAILABLE}
[junit4] 2> 2489689 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ChaosMonkey monkey: stop jetty! 33333
[junit4] 2> 2489708 INFO (qtp1879563970-22562) [n:127.0.0.1:44563_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
async=3a3e5919-300f-435e-bace-e121b1616fa8&action=ADDREPLICA&collection=solr_9504&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2489709 INFO (qtp1879563970-22562) [n:127.0.0.1:44563_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={async=3a3e5919-300f-435e-bace-e121b1616fa8&action=ADDREPLICA&collection=solr_9504&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2489709 INFO
(OverseerCollectionConfigSetProcessor-99283092987510790-127.0.0.1:44563_solr-n_0000000000)
[n:127.0.0.1:44563_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> 2489710 INFO
(OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:44563_solr for creating new replica
[junit4] 2> 2490709 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ChaosMonkey monkey: starting jetty! 33333
[junit4] 2> 2490710 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2490711 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@293bafb5{/solr,null,AVAILABLE}
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@32839f8{SSL,[ssl,
http/1.1]}{127.0.0.1:33333}
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.Server Started @2492627ms
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=33333}
[junit4] 2> 2490712 ERROR
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2490712 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-03T00:36:17.947940Z
[junit4] 2> 2490716 INFO (zkConnectionManagerCallback-4350-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2490717 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2490725 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39971/solr
[junit4] 2> 2490726 INFO (zkConnectionManagerCallback-4354-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2490729 INFO
(zkConnectionManagerCallback-4356-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2490731 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 2490732 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2490733 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33333_solr
[junit4] 2> 2490734 INFO (zkCallback-4347-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2490734 INFO
(zkCallback-4337-thread-1-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2490740 INFO
(zkCallback-4355-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 2490794 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2490806 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2490806 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2490808 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/.
[junit4] 2> 2490809 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC])
[n:127.0.0.1:33333_solr ] o.a.s.c.CorePropertiesLocator Cores are:
[solr_9504_shard1_replica_n1]
[junit4] 2> 2490809 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 2490812 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2490828 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.s.IndexSchema [solr_9504_shard1_replica_n1]
Schema name=minimal
[junit4] 2> 2490829 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with
uniqueid field id
[junit4] 2> 2490835 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.0.0
[junit4] 2> 2490839 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema
[solr_9504_shard1_replica_n1] Schema name=minimal
[junit4] 2> 2490840 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1
with uniqueid field id
[junit4] 2> 2490840 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore
'solr_9504_shard1_replica_n1' using configuration from collection solr_9504,
trusted=true
[junit4] 2> 2490840 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_33333.solr.core.solr_9504.shard1.replica_n1' (registry
'solr.core.solr_9504.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@e8c54a3
[junit4] 2> 2490840 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2490840 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [[solr_9504_shard1_replica_n1]
] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/solr_9504_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001/tempDir-001/node2/./solr_9504_shard1_replica_n1/data/]
[junit4] 2> 2490862 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2490862 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2490882 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2490883 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2490886 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1becd156[solr_9504_shard1_replica_n1] main]
[junit4] 2> 2490887 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/config
[junit4] 2> 2490887 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/config
[junit4] 2> 2490887 INFO
(coreLoadExecutor-7904-thread-1-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2490889 INFO
(searcherExecutor-7905-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1]
Registered new searcher Searcher@1becd156[solr_9504_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C10)))}
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the
new leader - try and sync
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SyncStrategy
https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ has no replicas
[junit4] 2> 2490894 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 2490895 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: https://127.0.0.1:33333/solr/solr_9504_shard1_replica_n1/ shard1
[junit4] 2> 2490895 INFO
(coreZkRegister-7899-thread-1-processing-n:127.0.0.1:33333_solr
x:solr_9504_shard1_replica_n1 s:shard1 c:solr_9504 r:core_node2)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2519807 ERROR
(OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.OverseerCollectionMessageHandler
Collection: solr_9504 operation: addreplica
failed:org.apache.solr.common.SolrException: Timed out waiting to see all
replicas: [solr_9504_shard1_replica_n3] in cluster state. Last state:
DocCollection(solr_9504//collections/solr_9504/state.json/4)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":"solr_9504_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:33333/solr";,
[junit4] 2> "node_name":"127.0.0.1:33333_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "leader":"true"}}}},
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0"}
[junit4] 2> at
org.apache.solr.cloud.OverseerCollectionMessageHandler.waitToSeeReplicasInState(OverseerCollectionMessageHandler.java:714)
[junit4] 2> at
org.apache.solr.cloud.AddReplicaCmd.addReplica(AddReplicaCmd.java:121)
[junit4] 2> at
org.apache.solr.cloud.AddReplicaCmd.call(AddReplicaCmd.java:73)
[junit4] 2> at
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:242)
[junit4] 2> at
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:464)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1135)
[junit4] 2> at
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2>
[junit4] 2> 2519808 INFO
(OverseerThreadFactory-7887-thread-2-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2521717 INFO
(OverseerCollectionConfigSetProcessor-99283092987510790-127.0.0.1:44563_solr-n_0000000000)
[n:127.0.0.1:44563_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2580997 INFO
(TEST-TestLeaderElectionWithEmptyReplica.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestLeaderElectionWithEmptyReplica -Dtests.method=test
-Dtests.seed=4A6ABB09D249B2AC -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=en-FM -Dtests.timezone=Asia/Manila -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 91.4s J1 | TestLeaderElectionWithEmptyReplica.test <<<
[junit4] > Throwable #1: java.util.concurrent.TimeoutException
[junit4] > at
__randomizedtesting.SeedInfo.seed([4A6ABB09D249B2AC:C23E84D37CB5DF54]:0)
[junit4] > at
org.apache.solr.common.cloud.ZkStateReader.waitForState(ZkStateReader.java:1261)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.waitForState(CloudSolrClient.java:449)
[junit4] > at
org.apache.solr.cloud.TestLeaderElectionWithEmptyReplica.test(TestLeaderElectionWithEmptyReplica.java:97)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@32839f8{SSL,[ssl,
http/1.1]}{127.0.0.1:33333}
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@7118407c{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=131347605
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1771540959
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@22b95fad: rootName =
solr_33333, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@7fa92172
[junit4] 2> 2581000 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f473fde: rootName =
solr_44563, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@13143cee
[junit4] 2> 2581006 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2581006 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 2581006 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@75e15442: rootName =
solr_33333, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a
[junit4] 2> 2581006 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@c89736f: rootName =
solr_44563, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@4ad8b71a
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4078f53e: rootName =
solr_44563, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1137062b: rootName =
solr_33333, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@334360d0
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:44563_solr
[junit4] 2> 2581011 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:33333_solr
[junit4] 2> 2581013 INFO (jetty-closer-4320-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 2581013 INFO
(zkCallback-4337-thread-2-processing-n:127.0.0.1:44563_solr)
[n:127.0.0.1:44563_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.c.SolrCore [solr_9504_shard1_replica_n1]
CLOSING SolrCore org.apache.solr.core.SolrCore@4e81073c
[junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.solr_9504.shard1.replica_n1, tag=1317078844
[junit4] 2> 2581013 INFO (coreCloseExecutor-7910-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@647a978: rootName =
solr_33333, domain = solr.core.solr_9504.shard1.replica_n1, service url = null,
agent id = null] for registry solr.core.solr_9504.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@5d6ee2ac
[junit4] 2> 2581013 INFO (jetty-closer-4320-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=99283092987510790-127.0.0.1:44563_solr-n_0000000000) closing
[junit4] 2> 2581013 INFO
(OverseerStateUpdate-99283092987510790-127.0.0.1:44563_solr-n_0000000000)
[n:127.0.0.1:44563_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:44563_solr
[junit4] 2> 2581016 WARN
(OverseerAutoScalingTriggerThread-99283092987510790-127.0.0.1:44563_solr-n_0000000000)
[n:127.0.0.1:44563_solr ] o.a.s.c.a.OverseerTriggerThread
OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2581017 INFO (jetty-closer-4320-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1c9a2646{/solr,null,UNAVAILABLE}
[junit4] 2> 2581021 INFO
(zkCallback-4355-thread-2-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (0)
[junit4] 2> 2581021 INFO
(zkCallback-4355-thread-3-processing-n:127.0.0.1:33333_solr)
[n:127.0.0.1:33333_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:33333_solr
[junit4] 2> 2581021 INFO (coreCloseExecutor-7910-thread-1)
[n:127.0.0.1:33333_solr c:solr_9504 s:shard1 r:core_node2
x:solr_9504_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.solr_9504.shard1.leader, tag=1317078844
[junit4] 2> 2581025 INFO (jetty-closer-4320-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@293bafb5{/solr,null,UNAVAILABLE}
[junit4] 2> 2581025 ERROR
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] 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> 2581025 INFO
(SUITE-TestLeaderElectionWithEmptyReplica-seed#[4A6ABB09D249B2AC]-worker) [
] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39971 39971
[junit4] 2> 2586142 INFO (Thread-6134) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:39971 39971
[junit4] 2> 2586142 WARN (Thread-6134) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/config
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/collections/solr_9504/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 2
/solr/overseer_elect/election/99283092987510790-127.0.0.1:44563_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/live_nodes
[junit4] 2> 4 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.TestLeaderElectionWithEmptyReplica_4A6ABB09D249B2AC-001
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@16cd8f16),
locale=en-FM, timezone=Asia/Manila
[junit4] 2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 10-ea
(64-bit)/cpus=8,threads=1,free=316973960,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[SimpleCollectionCreateDeleteTest, TestFastLRUCache, AtomicUpdatesTest,
TestUtilizeNode, TestSolrCloudWithHadoopAuthPlugin, DOMUtilTest,
TestCollationField, TestLuceneMatchVersion, TestStressCloudBlindAtomicUpdates,
SpellingQueryConverterTest, SuggesterTSTTest, SolrCmdDistributorTest,
SOLR749Test, TestNumericTokenStream, RemoteQueryErrorTest,
SolrMetricReporterTest, TestCoreBackup, CreateCollectionCleanupTest,
TestCorePropertiesReload, HdfsLockFactoryTest, ClusterStateUpdateTest,
TestBinaryResponseWriter, SaslZkACLProviderTest, TestPolicyCloud,
TestReRankQParserPlugin, WrapperMergePolicyFactoryTest,
SignatureUpdateProcessorFactoryTest, DistributedVersionInfoTest,
DistributedFacetPivotLongTailTest, MissingSegmentRecoveryTest,
SolrSlf4jReporterTest, TestClusterProperties, ChaosMonkeySafeLeaderTest,
TestFieldCacheVsDocValues, AddReplicaTest, QueryResultKeyTest,
TestQuerySenderNoQuery, TestJmxIntegration, CoreMergeIndexesAdminHandlerTest,
TestExpandComponent, TestXmlQParser, TestCursorMarkWithoutUniqueKey,
RegexBoostProcessorTest, CloudExitableDirectoryReaderTest,
BlockJoinFacetDistribTest, TestLocalFSCloudBackupRestore, AnalyticsQueryTest,
OpenCloseCoreStressTest, BlockDirectoryTest, TestLargeCluster,
ZkSolrClientTest, PrimUtilsTest, DeleteLastCustomShardedReplicaTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, BasicAuthIntegrationTest,
SolrIndexSplitterTest, TestScoreJoinQPNoScore, TestRTGBase, AssignTest,
CloudMLTQParserTest, TestAnalyzeInfixSuggestions, HealthCheckHandlerTest,
HighlighterConfigTest, TestPullReplicaErrorHandling, StatsReloadRaceTest,
TestDistribStateManager, TestFieldCacheReopen, TestPointFields,
LukeRequestHandlerTest, SolrXmlInZkTest, DocumentAnalysisRequestHandlerTest,
TestMacros, DebugComponentTest, TestCloudInspectUtil,
ManagedSchemaRoundRobinCloudTest, TestRemoteStreaming, TestSQLHandlerNonCloud,
TestQueryWrapperFilter, SynonymTokenizerTest, StressHdfsTest,
MetricsConfigTest, LeaderFailoverAfterPartitionTest, MergeStrategyTest,
OutputWriterTest, TestCloudPseudoReturnFields, TestSolrCloudSnapshots,
ClassificationUpdateProcessorTest, TestSimpleTrackingShardHandler,
OverseerModifyCollectionTest, ResponseHeaderTest, ConvertedLegacyTest,
TestCryptoKeys, PingRequestHandlerTest,
ConcurrentDeleteAndCreateCollectionTest, TestNRTOpen,
TestAtomicUpdateErrorCases, TestMultiValuedNumericRangeQuery,
TestNumericTerms32, TestFieldTypeCollectionResource,
CachingDirectoryFactoryTest, TestShortCircuitedRequests,
AutoscalingHistoryHandlerTest, TestExactSharedStatsCache,
RestartWhileUpdatingTest, TestFreeTextSuggestions, NotRequiredUniqueKeyTest,
SearchHandlerTest, TestFaceting, TestStressReorder,
TestSolrCloudWithDelegationTokens, TestLegacyFieldReuse,
TriggerIntegrationTest, TestSolr4Spatial, RegexBytesRefFilterTest,
TestConfigSetsAPI, PropertiesRequestHandlerTest, BooleanFieldTest, SampleTest,
TestManagedSynonymFilterFactory, DistributedSuggestComponentTest,
TestImplicitCoreProperties, SchemaVersionSpecificBehaviorTest,
BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest,
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, RecoveryZkTest,
TestReplicationHandler, ZkCLITest, StatsComponentTest, SpellCheckComponentTest,
QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestFiltering,
BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest,
ShowFileRequestHandlerTest, SimplePostToolTest, TestCoreDiscovery,
AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SuggesterFSTTest,
CoreAdminHandlerTest, PolyFieldTest, TestUpdate,
TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest,
IndexBasedSpellCheckerTest, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest,
XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest,
TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest,
IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, ReturnFieldsTest,
MBeansHandlerTest, MultiTermTest, TestDocSet, NumericFieldsTest,
TestElisionMultitermQuery, DirectSolrConnectionTest,
SpellPossibilityIteratorTest, TestXIncludeConfig, EchoParamsTest,
TestDFRSimilarityFactory, TestPerFieldSimilarity,
TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory,
TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest,
DateFieldTest, SliceStateTest, FileUtilsTest, DistributedIntervalFacetingTest,
ConnectionReuseTest, AsyncCallRequestStatusResponseTest,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConfigSetsAPITest,
ConnectionManagerTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest,
DistribDocExpirationUpdateProcessorTest, DistributedQueueTest,
LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest,
MoveReplicaHDFSFailoverTest, MoveReplicaTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverseerCollectionConfigSetProcessorTest, OverseerRolesTest,
OverseerTaskQueueTest, RecoveryAfterSoftCommitTest,
SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudDeleteByQuery,
TestCloudJSONFacetJoinDomain, TestCloudPivotFacet, TestCloudSearcherWarming,
TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster,
TestLeaderElectionWithEmptyReplica]
[junit4] Completed [559/765 (1!)] on J1 in 100.02s, 1 test, 1 error <<<
FAILURES!
[...truncated 800 lines...]
[junit4] Suite: org.apache.solr.schema.TestCloudSchemaless
[junit4] 2> 3215349 INFO
(SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestCloudSchemaless_4A6ABB09D249B2AC-001/init-core-data-001
[junit4] 2> 3215349 WARN
(SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=23 numCloses=23
[junit4] 2> 3215350 INFO
(SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 3215350 INFO
(SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-5776";)
[junit4] 2> 3215350 INFO
(SUITE-TestCloudSchemaless-seed#[4A6ABB09D249B2AC]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /bix/
[junit4] 2> 3215352 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3215353 INFO (Thread-7447) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3215353 INFO (Thread-7447) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 3215358 ERROR (Thread-7447) [ ] 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> 3215453 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.ZkTestServer start zk server on port:43529
[junit4] 2> 3215454 INFO (zkConnectionManagerCallback-5620-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3215455 INFO (zkConnectionManagerCallback-5622-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 3215457 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-schemaless.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 3215457 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/schema-add-schema-fields-update-processor.xml
to /configs/conf1/schema.xml
[junit4] 2> 3215458 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3215458 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 3215458 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 3215459 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 3215459 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 3215459 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 3215460 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3215460 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 3215460 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 3215461 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 3215535 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server
jetty-9.3.20.v20170531
[junit4] 2> 3215537 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@42e87429{/bix,null,AVAILABLE}
[junit4] 2> 3215537 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@8ecf2ca{HTTP/1.1,[http/1.1]}{127.0.0.1:34559}
[junit4] 2> 3215537 INFO
(TEST-TestCloudSchemaless.test-seed#[4A6ABB09D249B2AC]) [ ] o.e.j.s.Server
Started @3217453ms
[junit4] 2> 3215537 INFO (TEST-TestCloudSchemaless.test-seed#[
[...truncated too long message...]
ava.base/java.lang.Thread.run(Thread.java:844)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at
java.base/java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
[junit4] > at
java.base/java.net.SocketInputStream.read(SocketInputStream.java:171)
[junit4] > at
java.base/java.net.SocketInputStream.read(SocketInputStream.java:141)
[junit4] > at
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
[junit4] > at
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
[junit4] > at
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:282)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
[junit4] > at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
[junit4] > at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
[junit4] > at
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
[junit4] > at
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
[junit4] > at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
[junit4] > at
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
[junit4] > at
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
[junit4] > at
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
[junit4] > at
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
[junit4] > at
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
[junit4] > at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
[junit4] > ... 42 more
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.schema.TestCloudSchemaless_4A6ABB09D249B2AC-001
[junit4] 2> Jan 03, 2018 12:58:53 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1170, maxMBSortInHeap=5.994875124160612,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3ad643b1),
locale=ln-CD, timezone=Australia/Perth
[junit4] 2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 10-ea
(64-bit)/cpus=8,threads=1,free=338751824,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[SimpleCollectionCreateDeleteTest, TestFastLRUCache, AtomicUpdatesTest,
TestUtilizeNode, TestSolrCloudWithHadoopAuthPlugin, DOMUtilTest,
TestCollationField, TestLuceneMatchVersion, TestStressCloudBlindAtomicUpdates,
SpellingQueryConverterTest, SuggesterTSTTest, SolrCmdDistributorTest,
SOLR749Test, TestNumericTokenStream, RemoteQueryErrorTest,
SolrMetricReporterTest, TestCoreBackup, CreateCollectionCleanupTest,
TestCorePropertiesReload, HdfsLockFactoryTest, ClusterStateUpdateTest,
TestBinaryResponseWriter, SaslZkACLProviderTest, TestPolicyCloud,
TestReRankQParserPlugin, WrapperMergePolicyFactoryTest,
SignatureUpdateProcessorFactoryTest, DistributedVersionInfoTest,
DistributedFacetPivotLongTailTest, MissingSegmentRecoveryTest,
SolrSlf4jReporterTest, TestClusterProperties, ChaosMonkeySafeLeaderTest,
TestFieldCacheVsDocValues, AddReplicaTest, QueryResultKeyTest,
TestQuerySenderNoQuery, TestJmxIntegration, CoreMergeIndexesAdminHandlerTest,
TestExpandComponent, TestXmlQParser, TestCursorMarkWithoutUniqueKey,
RegexBoostProcessorTest, CloudExitableDirectoryReaderTest,
BlockJoinFacetDistribTest, TestLocalFSCloudBackupRestore, AnalyticsQueryTest,
OpenCloseCoreStressTest, BlockDirectoryTest, TestLargeCluster,
ZkSolrClientTest, PrimUtilsTest, DeleteLastCustomShardedReplicaTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, BasicAuthIntegrationTest,
SolrIndexSplitterTest, TestScoreJoinQPNoScore, TestRTGBase, AssignTest,
CloudMLTQParserTest, TestAnalyzeInfixSuggestions, HealthCheckHandlerTest,
HighlighterConfigTest, TestPullReplicaErrorHandling, StatsReloadRaceTest,
TestDistribStateManager, TestFieldCacheReopen, TestPointFields,
LukeRequestHandlerTest, SolrXmlInZkTest, DocumentAnalysisRequestHandlerTest,
TestMacros, DebugComponentTest, TestCloudInspectUtil,
ManagedSchemaRoundRobinCloudTest, TestRemoteStreaming, TestSQLHandlerNonCloud,
TestQueryWrapperFilter, SynonymTokenizerTest, StressHdfsTest,
MetricsConfigTest, LeaderFailoverAfterPartitionTest, MergeStrategyTest,
OutputWriterTest, TestCloudPseudoReturnFields, TestSolrCloudSnapshots,
ClassificationUpdateProcessorTest, TestSimpleTrackingShardHandler,
OverseerModifyCollectionTest, ResponseHeaderTest, ConvertedLegacyTest,
TestCryptoKeys, PingRequestHandlerTest,
ConcurrentDeleteAndCreateCollectionTest, TestNRTOpen,
TestAtomicUpdateErrorCases, TestMultiValuedNumericRangeQuery,
TestNumericTerms32, TestFieldTypeCollectionResource,
CachingDirectoryFactoryTest, TestShortCircuitedRequests,
AutoscalingHistoryHandlerTest, TestExactSharedStatsCache,
RestartWhileUpdatingTest, TestFreeTextSuggestions, NotRequiredUniqueKeyTest,
SearchHandlerTest, TestFaceting, TestStressReorder,
TestSolrCloudWithDelegationTokens, TestLegacyFieldReuse,
TriggerIntegrationTest, TestSolr4Spatial, RegexBytesRefFilterTest,
TestConfigSetsAPI, PropertiesRequestHandlerTest, BooleanFieldTest, SampleTest,
TestManagedSynonymFilterFactory, DistributedSuggestComponentTest,
TestImplicitCoreProperties, SchemaVersionSpecificBehaviorTest,
BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest,
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, RecoveryZkTest,
TestReplicationHandler, ZkCLITest, StatsComponentTest, SpellCheckComponentTest,
QueryElevationComponentTest, BadIndexSchemaTest, TestSort, TestFiltering,
BasicFunctionalityTest, TestLazyCores, DirectUpdateHandlerTest,
ShowFileRequestHandlerTest, SimplePostToolTest, TestCoreDiscovery,
AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SuggesterFSTTest,
CoreAdminHandlerTest, PolyFieldTest, TestUpdate,
TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest,
IndexBasedSpellCheckerTest, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest,
XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest,
TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest,
IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, ReturnFieldsTest,
MBeansHandlerTest, MultiTermTest, TestDocSet, NumericFieldsTest,
TestElisionMultitermQuery, DirectSolrConnectionTest,
SpellPossibilityIteratorTest, TestXIncludeConfig, EchoParamsTest,
TestDFRSimilarityFactory, TestPerFieldSimilarity,
TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory,
TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, PreAnalyzedFieldTest,
DateFieldTest, SliceStateTest, FileUtilsTest, DistributedIntervalFacetingTest,
ConnectionReuseTest, AsyncCallRequestStatusResponseTest,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, ConfigSetsAPITest,
ConnectionManagerTest, DeleteNodeTest, DeleteShardTest, DeleteStatusTest,
DistribDocExpirationUpdateProcessorTest, DistributedQueueTest,
LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest,
MoveReplicaHDFSFailoverTest, MoveReplicaTest,
OutOfBoxZkACLAndCredentialsProvidersTest,
OverseerCollectionConfigSetProcessorTest, OverseerRolesTest,
OverseerTaskQueueTest, RecoveryAfterSoftCommitTest,
SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, TestCloudDeleteByQuery,
TestCloudJSONFacetJoinDomain, TestCloudPivotFacet, TestCloudSearcherWarming,
TestCollectionAPI, TestCollectionsAPIViaSolrCloudCluster,
TestLeaderElectionWithEmptyReplica, TestRandomFlRTGCloud,
TestRequestForwarding, TestRequestStatusCollectionAPI,
TestSizeLimitedDistributedMap, TestSkipOverseerOperations,
TestStressInPlaceUpdates, TestTolerantUpdateProcessorRandomCloud,
VMParamsZkACLAndCredentialsProvidersTest, AutoAddReplicasPlanActionTest,
ExecutePlanActionTest, MetricTriggerTest, NodeAddedTriggerTest,
NodeLostTriggerTest, SystemLogListenerTest, TestPolicyCloud,
HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest,
HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest,
HdfsNNFailoverTest, HdfsTlogReplayBufferedWhileIndexingTest,
HdfsWriteToMultipleCollectionsTest, TestClusterStateMutator, ZkStateReaderTest,
CoreSorterTest, DirectoryFactoryTest, ExitableDirectoryReaderTest,
TestConfigOverlay, TestConfigSetImmutable, TestConfigSets,
TestInfoStreamLogging, TestSimpleTextCodec, TestSolrXml, TestBlobHandler,
TestSystemCollAutoCreate, TestNumericRangeQuery32, JvmMetricsTest,
SolrCoreMetricManagerTest, SolrMetricsIntegrationTest, SolrGangliaReporterTest,
SolrGraphiteReporterTest, SolrCloudReportersTest, TestStreamBody,
JSONWriterTest, TestCustomDocTransformer, TestExportWriter,
TestGeoJSONResponseWriter, TestPushWriter, TestRawResponseWriter,
TestRawTransformer, TestRetrieveFieldsOptimizer, TestSubQueryTransformer,
TestManagedResource, TestBulkSchemaAPI, TestSchemaResource,
TestSerializedLuceneMatchVersion, ChangedSchemaMergeTest, DateRangeFieldTest,
EnumFieldTest, SpatialRPTFieldTypeTest, TestCloudSchemaless]
[junit4] Completed [765/765 (2!)] on J1 in 631.55s, 1 test, 1 error <<<
FAILURES!
[...truncated 40780 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
