Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1294/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test
Error Message:
Expected 2 of 3 replicas to be active but only found 1;
[core_node3:{"core":"c8n_1x3_lf_shard1_replica2","base_url":"http://127.0.0.1:36008/ww/c","node_name":"127.0.0.1:36008_ww%2Fc","state":"active","leader":"true"}];
clusterState: DocCollection(c8n_1x3_lf//clusterstate.json/30)={
"replicationFactor":"3", "shards":{"shard1":{
"range":"80000000-7fffffff", "state":"active", "replicas":{
"core_node1":{ "state":"down",
"base_url":"http://127.0.0.1:45571/ww/c";,
"core":"c8n_1x3_lf_shard1_replica1",
"node_name":"127.0.0.1:45571_ww%2Fc"}, "core_node2":{
"core":"c8n_1x3_lf_shard1_replica3",
"base_url":"http://127.0.0.1:51428/ww/c";,
"node_name":"127.0.0.1:51428_ww%2Fc", "state":"down"},
"core_node3":{ "core":"c8n_1x3_lf_shard1_replica2",
"base_url":"http://127.0.0.1:36008/ww/c";,
"node_name":"127.0.0.1:36008_ww%2Fc", "state":"active",
"leader":"true"}}}}, "router":{"name":"compositeId"},
"maxShardsPerNode":"1", "autoAddReplicas":"false", "realtimeReplicas":"1"}
Stack Trace:
java.lang.AssertionError: Expected 2 of 3 replicas to be active but only found
1;
[core_node3:{"core":"c8n_1x3_lf_shard1_replica2","base_url":"http://127.0.0.1:36008/ww/c","node_name":"127.0.0.1:36008_ww%2Fc","state":"active","leader":"true"}];
clusterState: DocCollection(c8n_1x3_lf//clusterstate.json/30)={
"replicationFactor":"3",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{
"core_node1":{
"state":"down",
"base_url":"http://127.0.0.1:45571/ww/c";,
"core":"c8n_1x3_lf_shard1_replica1",
"node_name":"127.0.0.1:45571_ww%2Fc"},
"core_node2":{
"core":"c8n_1x3_lf_shard1_replica3",
"base_url":"http://127.0.0.1:51428/ww/c";,
"node_name":"127.0.0.1:51428_ww%2Fc",
"state":"down"},
"core_node3":{
"core":"c8n_1x3_lf_shard1_replica2",
"base_url":"http://127.0.0.1:36008/ww/c";,
"node_name":"127.0.0.1:36008_ww%2Fc",
"state":"active",
"leader":"true"}}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false",
"realtimeReplicas":"1"}
at
__randomizedtesting.SeedInfo.seed([628E950496C2FCA:8E7CD68AE7904232]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.testRf3WithLeaderFailover(LeaderFailoverAfterPartitionTest.java:170)
at
org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test(LeaderFailoverAfterPartitionTest.java:57)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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
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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.update.AutoCommitTest.testMaxDocs
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([628E950496C2FCA:BFA93F8F65862B40]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
at
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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
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.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:14&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
... 40 more
Build Log:
[...truncated 11283 lines...]
[junit4] Suite: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/init-core-data-001
[junit4] 2> 342964 WARN
(SUITE-LeaderFailoverAfterPartitionTest-seed#[628E950496C2FCA]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=12 numCloses=12
[junit4] 2> 342964 INFO
(SUITE-LeaderFailoverAfterPartitionTest-seed#[628E950496C2FCA]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 342967 INFO
(SUITE-LeaderFailoverAfterPartitionTest-seed#[628E950496C2FCA]-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> 342967 INFO
(SUITE-LeaderFailoverAfterPartitionTest-seed#[628E950496C2FCA]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ww/c
[junit4] 2> 342969 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 342969 INFO (Thread-517) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 342969 INFO (Thread-517) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 342972 ERROR (Thread-517) [ ] 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> 343072 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkTestServer start zk server on port:61275
[junit4] 2> 343095 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 343101 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 343105 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 343109 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 343113 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 343116 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 343120 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 343127 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 343132 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 343135 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 343137 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 343381 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/cores/collection1
[junit4] 2> 343384 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 343386 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6780c87d{/ww/c,null,AVAILABLE}
[junit4] 2> 343388 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6a1464e4{HTTP/1.1,[http/1.1]}{127.0.0.1:36545}
[junit4] 2> 343388 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server Started @347497ms
[junit4] 2> 343389 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/tempDir-001/control/data,
hostContext=/ww/c, hostPort=36008,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/cores}
[junit4] 2> 343389 ERROR
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 343389 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 343389 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 343389 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 343389 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-10T03:41:01.618Z
[junit4] 2> 343399 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 343399 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/solr.xml
[junit4] 2> 343407 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 343412 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61275/solr
[junit4] 2> 343485 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 343486 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36008_ww%2Fc
[junit4] 2> 343489 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.Overseer Overseer
(id=97936189764403204-127.0.0.1:36008_ww%2Fc-n_0000000000) starting
[junit4] 2> 343508 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36008_ww%2Fc
[junit4] 2> 343512 INFO
(zkCallback-445-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 343691 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 343699 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 343699 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 343701 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/cores
[junit4] 2> 343701 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 343703 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 343718 INFO
(OverseerStateUpdate-97936189764403204-127.0.0.1:36008_ww%2Fc-n_0000000000)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 344748 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 344782 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 344946 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 344973 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection, trusted=true
[junit4] 2> 344973 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.core_node1' (registry
'solr.core.control_collection.shard1.core_node1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 344974 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 344974 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/cores/collection1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/control-001/cores/collection1/data/]
[junit4] 2> 344977 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=182870149,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 344982 WARN
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 345070 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 345070 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 345071 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 345071 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 345073 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 345073 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6987185f[collection1] main]
[junit4] 2> 345077 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 345078 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 345079 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 345079 INFO
(coreLoadExecutor-1272-thread-1-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc c:control_collection x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1566979038440849408
[junit4] 2> 345089 INFO
(searcherExecutor-1273-thread-1-processing-n:127.0.0.1:36008_ww%2Fc
x:collection1 c:control_collection) [n:127.0.0.1:36008_ww%2Fc
c:control_collection x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@6987185f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36008/ww/c/collection1/
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:36008/ww/c/collection1/ has no replicas
[junit4] 2> 345095 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 345109 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:36008/ww/c/collection1/ shard1
[junit4] 2> 345263 INFO
(coreZkRegister-1265-thread-1-processing-n:127.0.0.1:36008_ww%2Fc x:collection1
c:control_collection) [n:127.0.0.1:36008_ww%2Fc c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 345286 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 345292 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61275/solr ready
[junit4] 2> 345292 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 345591 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/cores/collection1
[junit4] 2> 345592 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001
[junit4] 2> 345593 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 345596 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7795643{/ww/c,null,AVAILABLE}
[junit4] 2> 345596 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@f5f61a4{HTTP/1.1,[http/1.1]}{127.0.0.1:58040}
[junit4] 2> 345597 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server Started @349706ms
[junit4] 2> 345597 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/ww/c, hostPort=45571,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/cores}
[junit4] 2> 345597 ERROR
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 345598 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 345599 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 345599 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 345599 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-10T03:41:03.828Z
[junit4] 2> 345607 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 345607 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/solr.xml
[junit4] 2> 345628 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 345633 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61275/solr
[junit4] 2> 345727 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 345739 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 345745 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45571_ww%2Fc
[junit4] 2> 345749 INFO
(zkCallback-445-thread-2-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 345751 INFO (zkCallback-449-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 345752 INFO
(zkCallback-454-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 345966 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 345983 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 345984 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 345988 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/cores
[junit4] 2> 345989 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 345991 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 345993 INFO
(OverseerStateUpdate-97936189764403204-127.0.0.1:36008_ww%2Fc-n_0000000000)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard2
[junit4] 2> 347032 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 347062 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 347225 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 347375 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 347376 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.core_node1' (registry
'solr.core.collection1.shard2.core_node1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 347376 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 347376 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/cores/collection1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-1-001/cores/collection1/data/]
[junit4] 2> 347382 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=182870149,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 347386 WARN
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 347556 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 347556 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 347557 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 347557 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 347558 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 347558 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@35bdcd8[collection1] main]
[junit4] 2> 347561 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 347561 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 347562 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 347563 INFO
(searcherExecutor-1284-thread-1-processing-n:127.0.0.1:45571_ww%2Fc
x:collection1 c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35bdcd8[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 347564 INFO
(coreLoadExecutor-1283-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566979041046560768
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:45571/ww/c/collection1/
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:45571/ww/c/collection1/
has no replicas
[junit4] 2> 347577 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 347586 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:45571/ww/c/collection1/ shard2
[junit4] 2> 347697 INFO
(coreZkRegister-1278-thread-1-processing-n:127.0.0.1:45571_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:45571_ww%2Fc c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 348277 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/cores/collection1
[junit4] 2> 348277 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001
[junit4] 2> 348278 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 348281 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1b6e8544{/ww/c,null,AVAILABLE}
[junit4] 2> 348281 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3181afed{HTTP/1.1,[http/1.1]}{127.0.0.1:57247}
[junit4] 2> 348281 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server Started @352391ms
[junit4] 2> 348281 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/ww/c, hostPort=51428,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/cores}
[junit4] 2> 348281 ERROR
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 348282 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 348282 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 348282 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 348282 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-10T03:41:06.511Z
[junit4] 2> 348288 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 348288 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/solr.xml
[junit4] 2> 348305 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 348310 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61275/solr
[junit4] 2> 348335 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 348349 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 348355 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:51428_ww%2Fc
[junit4] 2> 348358 INFO
(zkCallback-445-thread-2-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 348359 INFO (zkCallback-449-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 348359 INFO
(zkCallback-454-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 348361 INFO
(zkCallback-460-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 348526 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 348530 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 348530 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 348532 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/cores
[junit4] 2> 348532 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 348533 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 348535 INFO
(OverseerStateUpdate-97936189764403204-127.0.0.1:36008_ww%2Fc-n_0000000000)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 349555 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 349580 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 349705 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 349727 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 349729 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.core_node2' (registry
'solr.core.collection1.shard1.core_node2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 349729 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 349729 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/cores/collection1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-2-001/cores/collection1/data/]
[junit4] 2> 349732 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=182870149,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 349735 WARN
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 349798 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 349798 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 349799 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 349799 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 349800 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 349800 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@35cf9120[collection1] main]
[junit4] 2> 349802 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 349803 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 349803 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 349803 INFO
(coreLoadExecutor-1294-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566979043394322432
[junit4] 2> 349804 INFO
(searcherExecutor-1295-thread-1-processing-n:127.0.0.1:51428_ww%2Fc
x:collection1 c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35cf9120[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:51428/ww/c/collection1/
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:51428/ww/c/collection1/
has no replicas
[junit4] 2> 349812 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 349819 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:51428/ww/c/collection1/ shard1
[junit4] 2> 349971 INFO
(coreZkRegister-1289-thread-1-processing-n:127.0.0.1:51428_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:51428_ww%2Fc c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 350296 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/cores/collection1
[junit4] 2> 350297 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001
[junit4] 2> 350299 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 350300 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2c2d243e{/ww/c,null,AVAILABLE}
[junit4] 2> 350301 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6783be17{HTTP/1.1,[http/1.1]}{127.0.0.1:41734}
[junit4] 2> 350301 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.e.j.s.Server Started @354412ms
[junit4] 2> 350301 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/tempDir-001/jetty3,
solrconfig=solrconfig.xml, hostContext=/ww/c, hostPort=54432,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/cores}
[junit4] 2> 350301 ERROR
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 350302 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 350303 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 350303 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 350303 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-10T03:41:08.532Z
[junit4] 2> 350308 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 350309 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/solr.xml
[junit4] 2> 350324 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 350327 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61275/solr
[junit4] 2> 350346 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 350349 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 350354 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54432_ww%2Fc
[junit4] 2> 350358 INFO
(zkCallback-460-thread-1-processing-n:127.0.0.1:51428_ww%2Fc)
[n:127.0.0.1:51428_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 350360 INFO
(zkCallback-445-thread-2-processing-n:127.0.0.1:36008_ww%2Fc)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 350360 INFO (zkCallback-449-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 350361 INFO
(zkCallback-454-thread-1-processing-n:127.0.0.1:45571_ww%2Fc)
[n:127.0.0.1:45571_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 350361 INFO
(zkCallback-466-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 350571 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 350575 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 350576 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 350578 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/cores
[junit4] 2> 350578 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA])
[n:127.0.0.1:54432_ww%2Fc ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 350579 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 350584 INFO
(OverseerStateUpdate-97936189764403204-127.0.0.1:36008_ww%2Fc-n_0000000000)
[n:127.0.0.1:36008_ww%2Fc ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard2
[junit4] 2> 351604 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 351620 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 351724 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 351747 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 351748 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.core_node3' (registry
'solr.core.collection1.shard2.core_node3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@8e5100f
[junit4] 2> 351748 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 351748 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/cores/collection1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.LeaderFailoverAfterPartitionTest_628E950496C2FCA-001/shard-3-001/cores/collection1/data/]
[junit4] 2> 351751 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=182870149,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 351753 WARN
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 351830 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 351830 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 351832 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 351832 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 351834 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 351834 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@79a3acad[collection1] main]
[junit4] 2> 351836 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 351837 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 351838 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 351840 INFO
(searcherExecutor-1306-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 c:collection1) [n:127.0.0.1:54432_ww%2Fc c:collection1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@79a3acad[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 351840 INFO
(coreLoadExecutor-1305-thread-1-processing-n:127.0.0.1:54432_ww%2Fc)
[n:127.0.0.1:54432_ww%2Fc c:collection1 x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1566979045530271744
[junit4] 2> 351850 INFO
(coreZkRegister-1300-thread-1-processing-n:127.0.0.1:54432_ww%2Fc x:collection1
c:collection1) [n:127.0.0.1:54432_ww%2Fc c:collection1 s:shard2 r:core_node3
x:collection1] o.a.s.c.ZkController Core needs to recover:collection1
[junit4] 2> 351851 INFO
(updateExecutor-463-thread-1-processing-n:127.0.0.1:54432_ww%2Fc x:collection1
s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc c:collection1
s:shard2 r:core_node3 x:collection1] o.a.s.u.DefaultSolrCoreState Running
recovery
[junit4] 2> 351851 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 351853 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
###### startupVersions=[[]]
[junit4] 2> 351854 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Begin buffering updates. core=[collection1]
[junit4] 2> 351854 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.UpdateLog Starting
to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 351854 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Publishing state of core [collection1] as recovering, leader is
[http://127.0.0.1:45571/ww/c/collection1/] and I am
[http://127.0.0.1:54432/ww/c/collection1/]
[junit4] 2> 351859 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Sending prep recovery command to [http://127.0.0.1:45571/ww/c]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:54432_ww%252Fc&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 351862 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=59391,localport=45571], receiveBufferSize:130880
[junit4] 2> 351880 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=58040,localport=38924], receiveBufferSize=139264
[junit4] 2> 351888 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 351889 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard2 of collection1) have state: recovering
[junit4] 2> 351889 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard2, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=down, localState=active,
nodeName=127.0.0.1:54432_ww%2Fc, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:54432/ww/c","node_name":"127.0.0.1:54432_ww%2Fc","state":"down"}
[junit4] 2> 352142 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 352142 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Wait for recoveries to finish - wait
30000 for each attempt
[junit4] 2> 352142 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):30000
[junit4] 2> 352890 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard2, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=recovering, localState=active,
nodeName=127.0.0.1:54432_ww%2Fc, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:54432/ww/c","node_name":"127.0.0.1:54432_ww%2Fc","state":"recovering"}
[junit4] 2> 352890 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering,
checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4] 2> 352891 INFO (qtp692878753-2560) [n:127.0.0.1:45571_ww%2Fc
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:54432_ww%252Fc&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node3&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=1002
[junit4] 2> 353395 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Attempting to PeerSync from [http://127.0.0.1:45571/ww/c/collection1/] -
recoveringAfterStartup=[true]
[junit4] 2> 353396 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.PeerSync PeerSync:
core=collection1 url=http://127.0.0.1:54432/ww/c START
replicas=[http://127.0.0.1:45571/ww/c/collection1/] nUpdates=100
[junit4] 2> 353398 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=33910,localport=45571], receiveBufferSize:130880
[junit4] 2> 353398 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=58040,localport=60222], receiveBufferSize=139264
[junit4] 2> 353403 INFO (qtp692878753-2563) [n:127.0.0.1:45571_ww%2Fc
c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.u.IndexFingerprint
IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807,
maxVersionEncountered=0, maxInHash=0, versionsHash=0, numVersions=0, numDocs=0,
maxDoc=0}
[junit4] 2> 353404 INFO (qtp692878753-2563) [n:127.0.0.1:45571_ww%2Fc
c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.S.Request
[collection1] webapp=/ww/c path=/get
params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 353405 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.IndexFingerprint
IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807,
maxVersionEncountered=0, maxInHash=0, versionsHash=0, numVersions=0, numDocs=0,
maxDoc=0}
[junit4] 2> 353405 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.PeerSync We are
already in sync. No need to do a PeerSync
[junit4] 2> 353405 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.DirectUpdateHandler2
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 353405 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.DirectUpdateHandler2
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 353406 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.DirectUpdateHandler2
end_commit_flush
[junit4] 2> 353406 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
PeerSync stage of recovery was successful.
[junit4] 2> 353406 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Replaying updates buffered during PeerSync.
[junit4] 2> 353406 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy No
replay needed.
[junit4] 2> 353406 INFO
(recoveryExecutor-464-thread-1-processing-n:127.0.0.1:54432_ww%2Fc
x:collection1 s:shard2 c:collection1 r:core_node3) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.c.RecoveryStrategy
Registering as Active after recovery.
[junit4] 2> 354151 INFO
(TEST-LeaderFailoverAfterPartitionTest.test-seed#[628E950496C2FCA]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 354152 INFO (SocketProxy-Acceptor-36008) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=53247,localport=36008], receiveBufferSize:130880
[junit4] 2> 354156 INFO (SocketProxy-Acceptor-36008) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=36545,localport=43233], receiveBufferSize=139264
[junit4] 2> 354159 INFO (qtp1693922187-2522) [n:127.0.0.1:36008_ww%2Fc
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 354159 INFO (qtp1693922187-2522) [n:127.0.0.1:36008_ww%2Fc
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 354160 INFO (qtp1693922187-2522) [n:127.0.0.1:36008_ww%2Fc
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 354160 INFO (qtp1693922187-2522) [n:127.0.0.1:36008_ww%2Fc
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ww/c path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 2
[junit4] 2> 354162 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=50999,localport=45571], receiveBufferSize:130880
[junit4] 2> 354163 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=58040,localport=54157], receiveBufferSize=139264
[junit4] 2> 354172 INFO (SocketProxy-Acceptor-51428) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=63133,localport=51428], receiveBufferSize:130880
[junit4] 2> 354172 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=57831,localport=45571], receiveBufferSize:130880
[junit4] 2> 354173 INFO (SocketProxy-Acceptor-54432) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=62873,localport=54432], receiveBufferSize:130880
[junit4] 2> 354173 INFO (SocketProxy-Acceptor-51428) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=57247,localport=57447], receiveBufferSize=139264
[junit4] 2> 354174 INFO (SocketProxy-Acceptor-54432) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=41734,localport=36089], receiveBufferSize=139264
[junit4] 2> 354177 INFO (SocketProxy-Acceptor-45571) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=58040,localport=32771], receiveBufferSize=139264
[junit4] 2> 354183 INFO (qtp692878753-2557) [n:127.0.0.1:45571_ww%2Fc
c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.u.DirectUpdateHandler2
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 354183 INFO (qtp692878753-2557) [n:127.0.0.1:45571_ww%2Fc
c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.u.DirectUpdateHandler2
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 354185 INFO (qtp778032219-2588) [n:127.0.0.1:51428_ww%2Fc
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.u.DirectUpdateHandler2
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 354185 INFO (qtp1781939744-2617) [n:127.0.0.1:54432_ww%2Fc
c:collection1 s:shard2 r:core_node3 x:collection1] o.a.s.u.DirectUpdateHandler2
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 354185 INFO (qtp778032219-2588) [n:127.0.0.1:51428_ww%2Fc
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.u.DirectUpdateHandler2
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 354188 INFO (qtp778032219-2588) [n:127.0.0.1:51428_ww%2Fc
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.u.DirectUpdateHandler2
end_commit_flush
[junit4] 2> 354187 INFO (qtp692878753-2557) [n:127.0.0.1:45571_ww%2Fc
c:collection1 s:shard2 r:core_n
[...truncated too long message...]
java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 1703136 INFO
(TEST-AutoCommitTest.testMaxDocs-seed#[628E950496C2FCA]) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest
-Dtests.method=testMaxDocs -Dtests.seed=628E950496C2FCA -Dtests.slow=true
-Dtests.locale=nl-BE -Dtests.timezone=Europe/Kirov -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.56s J0 | AutoCommitTest.testMaxDocs <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during
query
[junit4] > at
__randomizedtesting.SeedInfo.seed([628E950496C2FCA:BFA93F8F65862B40]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:896)
[junit4] > at
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
[junit4] > </response>
[junit4] > request
was:q=id:14&qt=standard&start=0&rows=20&version=2.2
[junit4] > at
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:889)
[junit4] > ... 40 more
[junit4] 2> 1703137 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1703137 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=969393717
[junit4] 2> 1703137 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1703141 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1703143 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1703143 INFO (commitScheduler-6791-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1703144 INFO
(SUITE-AutoCommitTest-seed#[628E950496C2FCA]-worker) [ x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1703148 INFO (commitScheduler-6791-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2142567e[collection1] main]
[junit4] 2> 1703149 INFO (commitScheduler-6791-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1703149 INFO
(coreCloseExecutor-6792-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@30021a3c
[junit4] 2> 1703149 INFO
(coreCloseExecutor-6792-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 1703150 INFO
(coreCloseExecutor-6792-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@33a52c8 commitCommandVersion:0
[junit4] 2> 1703152 INFO
(searcherExecutor-6788-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2142567e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):c16)))}
[junit4] 2> 1703152 INFO
(coreCloseExecutor-6792-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=805444156
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.update.AutoCommitTest_628E950496C2FCA-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{range_facet_l_dv=PostingsFormat(name=LuceneVarGapFixedInterval),
field_t=PostingsFormat(name=LuceneVarGapFixedInterval), multiDefault=FST50,
subject=FST50, intDefault=PostingsFormat(name=LuceneFixedGap),
id=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_i_dv=FST50,
text=PostingsFormat(name=Asserting), range_facet_l=FST50, timestamp=FST50},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Memory),
range_facet_i_dv=DocValuesFormat(name=Lucene70),
intDvoDefault=DocValuesFormat(name=Lucene70),
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=912,
maxMBSortInHeap=5.469896864753947, sim=RandomSimilarity(queryNorm=true): {},
locale=nl-BE, timezone=Europe/Kirov
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_131
(64-bit)/cpus=3,threads=1,free=46316488,total=380518400
[junit4] 2> NOTE: All tests run in this JVM: [TestConfigOverlay,
TestSchemaVersionResource, BigEndianAscendingWordDeserializerTest,
TestHashPartitioner, TestRemoteStreaming, TestReplicationHandlerBackup,
TestSolrConfigHandler, SimpleFacetsTest, SolrRequestParserTest, FullHLLTest,
SolrGangliaReporterTest, CursorPagingTest, SolrCloudReportersTest,
TestUniqueKeyFieldResource, TestShortCircuitedRequests, TestFunctionQuery,
TestPayloadScoreQParserPlugin, UniqFieldsUpdateProcessorFactoryTest,
SolrTestCaseJ4Test, ClusterStateUpdateTest, BlockJoinFacetDistribTest,
JvmMetricsTest, TestRebalanceLeaders, TestFastOutputStream,
TestCollationFieldDocValues, TestMultiWordSynonyms, TestLazyCores,
TestSurroundQueryParser, TestConfigSetsAPI, TestPivotHelperCode,
TestReRankQParserPlugin, SortSpecParsingTest,
ClassificationUpdateProcessorFactoryTest, TestPhraseSuggestions,
PingRequestHandlerTest, ResourceLoaderTest, MigrateRouteKeyTest,
LeaderFailoverAfterPartitionTest, DistributedQueryComponentCustomSortTest,
TestManagedResourceStorage, TestBlendedInfixSuggestions, SyncSliceTest,
AddBlockUpdateTest, TestCloudJSONFacetJoinDomain,
TestSolrCloudWithSecureImpersonation, PathHierarchyTokenizerFactoryTest,
ClassificationUpdateProcessorTest, MetricUtilsTest, NodeMutatorTest,
TestElisionMultitermQuery, CopyFieldTest, TestDeleteCollectionOnDownNodes,
TestHdfsCloudBackupRestore, TestSolrFieldCacheBean, TestStressUserVersions,
RecoveryZkTest, ShardRoutingTest, TestComplexPhraseQParserPlugin,
CoreSorterTest, TestSolrConfigHandlerConcurrent, FastVectorHighlighterTest,
TestSolrDeletionPolicy1, BooleanFieldTest, DirectSolrSpellCheckerTest,
ZkCLITest, SuggestComponentContextFilterQueryTest,
PeerSyncWithIndexFingerprintCachingTest, QueryElevationComponentTest,
TestBinaryField, TestCoreContainer, FileUtilsTest, DateRangeFieldTest,
DocValuesMultiTest, DistributedFacetExistsSmallTest,
DistributedSuggestComponentTest, RuleEngineTest, TestCollapseQParserPlugin,
TestRuleBasedAuthorizationPlugin, TestMaxScoreQueryParser, TestFieldResource,
TestTestInjection, TestRestoreCore, TestSystemIdResolver,
XsltUpdateRequestHandlerTest, SimplePostToolTest, TestSolrJ,
TestQuerySenderNoQuery, TestJavabinTupleStreamParser, TestStressReorder,
HLLUtilTest, IndexBasedSpellCheckerTest, AtomicUpdateProcessorFactoryTest,
TestSolrCloudWithHadoopAuthPlugin, RestartWhileUpdatingTest,
SolrIndexConfigTest, TestFieldTypeResource, TestUpdate, TestJsonRequest,
TestMinMaxOnMultiValuedField, TestSolrCloudSnapshots, ReplaceNodeTest,
UUIDUpdateProcessorFallbackTest, CursorMarkTest, TestClusterProperties,
TestGraphTermsQParserPlugin, TestReloadDeadlock, BlockJoinFacetSimpleTest,
TestManagedSynonymFilterFactory, SolrJmxReporterTest,
TestCloudPseudoReturnFields, JsonValidatorTest, DateMathParserTest,
DateFieldTest, SOLR749Test, OverseerTest, SubstringBytesRefFilterTest,
CachingDirectoryFactoryTest, TestCharFilters, MergeStrategyTest,
SharedFSAutoReplicaFailoverUtilsTest, SolrMetricReporterTest,
TestRandomDVFaceting, TestSort, TestWordDelimiterFilterFactory,
DocExpirationUpdateProcessorFactoryTest, DistributedDebugComponentTest,
TestSolr4Spatial2, IndexSchemaRuntimeFieldTest,
SpellCheckCollatorWithCollapseTest, TestStressVersions,
TestMiniSolrCloudClusterSSL, SuggesterFSTTest, TestConfigReload,
CurrencyFieldXmlFileTest, ConnectionManagerTest, XmlUpdateRequestHandlerTest,
HdfsChaosMonkeySafeLeaderTest, OutputWriterTest,
CollectionsAPIAsyncDistributedZkTest, TestUnifiedSolrHighlighter,
UninvertDocValuesMergePolicyTest, TestSimpleQParserPlugin,
TestSuggestSpellingConverter, TestDelegationWithHadoopAuth,
DistributedSpellCheckComponentTest, DocumentBuilderTest,
DistributedFacetPivotSmallTest, TestPostingsSolrHighlighter,
TestTolerantUpdateProcessorCloud, OverseerTaskQueueTest,
TestBulkSchemaConcurrent, EnumFieldTest, TestExactSharedStatsCache,
PluginInfoTest, TestPseudoReturnFields, TestRandomCollapseQParserPlugin,
TestLocalFSCloudBackupRestore, TestPerFieldSimilarity, TestInitQParser,
SolrPluginUtilsTest, TlogReplayBufferedWhileIndexingTest,
TestCloudNestedDocsSort, TestBM25SimilarityFactory,
TestEmbeddedSolrServerConstructors, TestSolrQueryParserDefaultOperatorResource,
DocValuesTest, ShardSplitTest, CloudExitableDirectoryReaderTest,
RecoveryAfterSoftCommitTest, SegmentsInfoRequestHandlerTest, VersionInfoTest,
BasicDistributedZkTest, UnloadDistributedZkTest, TestReplicationHandler,
AutoCommitTest]
[junit4] Completed [368/710 (2!)] on J0 in 14.60s, 3 tests, 1 error <<<
FAILURES!
[...truncated 44547 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
