Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/3238/
Java: 64bit/jdk-9-ea+162 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.ShardSplitTest.testSplitWithChaosMonkey
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([7A53585934EF1B76:F1748B8875E9B0F2]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:187)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:144)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:139)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:865)
at
org.apache.solr.cloud.ShardSplitTest.testSplitWithChaosMonkey(ShardSplitTest.java:437)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:547)
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:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED:
org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults
Error Message:
mismatch: 'myid1'!='myid' @ response/docs/[0]/id
Stack Trace:
java.lang.RuntimeException: mismatch: 'myid1'!='myid' @ response/docs/[0]/id
at
__randomizedtesting.SeedInfo.seed([7A53585934EF1B76:48795FC7CC113FAF]:0)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:969)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:916)
at
org.apache.solr.schema.TestUseDocValuesAsStored.testMultipleSearchResults(TestUseDocValuesAsStored.java:243)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:547)
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
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 11628 lines...]
[junit4] Suite: org.apache.solr.cloud.ShardSplitTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/init-core-data-001
[junit4] 2> 151143 WARN
(SUITE-ShardSplitTest-seed#[7A53585934EF1B76]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
[junit4] 2> 151143 INFO
(SUITE-ShardSplitTest-seed#[7A53585934EF1B76]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 151144 INFO
(SUITE-ShardSplitTest-seed#[7A53585934EF1B76]-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> 151144 INFO
(SUITE-ShardSplitTest-seed#[7A53585934EF1B76]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ym/p
[junit4] 2> 151146 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 151146 INFO (Thread-327) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 151146 INFO (Thread-327) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 151246 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkTestServer start zk server on port:46084
[junit4] 2> 151252 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 151254 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 151257 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 151259 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 151261 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 151262 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 151264 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 151266 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 151268 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 151270 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 151272 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 151670 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/cores/collection1
[junit4] 2> 151671 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 151672 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6a0a5d7f{/ym/p,null,AVAILABLE}
[junit4] 2> 151673 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3045e521{HTTP/1.1,[http/1.1]}{127.0.0.1:37477}
[junit4] 2> 151673 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server Started @153258ms
[junit4] 2> 151673 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ym/p,
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/tempDir-001/control/data,
hostPort=37477,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/cores}
[junit4] 2> 151674 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 151674 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 151674 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 151674 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 151674 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-04-09T15:08:51.677383Z
[junit4] 2> 151676 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 151676 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/solr.xml
[junit4] 2> 151686 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 151687 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46084/solr
[junit4] 2> 151697 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 151697 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader
127.0.0.1:37477_ym%2Fp
[junit4] 2> 151698 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer
(id=97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) starting
[junit4] 2> 151702 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37477_ym%2Fp
[junit4] 2> 151702 INFO (zkCallback-494-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 151830 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/cores
[junit4] 2> 151830 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 151830 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 151832 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 152842 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0
[junit4] 2> 152854 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 152906 WARN (coreLoadExecutor-564-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 152907 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 152916 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection, trusted=true
[junit4] 2> 152920 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 152920 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/control-001/cores/collection1/data/]
[junit4] 2> 152920 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@44ac04d8
[junit4] 2> 152923 INFO (coreLoadExecutor-564-thread-1) [ ]
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.7602212447173758]
[junit4] 2> 152993 WARN (coreLoadExecutor-564-thread-1) [ ]
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> 153136 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 153137 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 153137 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 153137 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 153138 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=16.6865234375,
floorSegmentMB=0.3828125, forceMergeDeletesPctAllowed=19.447903559770637,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 153139 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@356e28e4[collection1] main]
[junit4] 2> 153140 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 153140 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 153140 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 153141 INFO (searcherExecutor-565-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@356e28e4[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 153141 INFO (coreLoadExecutor-564-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564213807042002944
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37477/ym/p/collection1/
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:37477/ym/p/collection1/ has no replicas
[junit4] 2> 153145 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 153147 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:37477/ym/p/collection1/ shard1
[junit4] 2> 153298 INFO (coreZkRegister-557-thread-1) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 153357 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 153358 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46084/solr ready
[junit4] 2> 153358 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 153784 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/cores/collection1
[junit4] 2> 153785 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001
[junit4] 2> 153785 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 153786 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4935acbc{/ym/p,null,AVAILABLE}
[junit4] 2> 153786 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1462e44d{HTTP/1.1,[http/1.1]}{127.0.0.1:46040}
[junit4] 2> 153787 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server Started @155371ms
[junit4] 2> 153787 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ym/p,
solrconfig=solrconfig.xml,
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/tempDir-001/jetty1,
hostPort=46040,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/cores}
[junit4] 2> 153787 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 153787 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 153787 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 153787 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 153788 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-04-09T15:08:53.791472Z
[junit4] 2> 153790 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 153790 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/solr.xml
[junit4] 2> 153795 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 153797 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46084/solr
[junit4] 2> 153802 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 153803 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 153804 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46040_ym%2Fp
[junit4] 2> 153805 INFO (zkCallback-503-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 153805 INFO (zkCallback-498-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 153805 INFO (zkCallback-494-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 153897 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/cores
[junit4] 2> 153897 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 153898 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 153899 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 154908 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0
[junit4] 2> 154920 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 155003 WARN (coreLoadExecutor-575-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 155005 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 155017 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection collection1, trusted=true
[junit4] 2> 155018 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 155018 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-1-001/cores/collection1/data/]
[junit4] 2> 155018 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@44ac04d8
[junit4] 2> 155022 INFO (coreLoadExecutor-575-thread-1) [ ]
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.7602212447173758]
[junit4] 2> 155081 WARN (coreLoadExecutor-575-thread-1) [ ]
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> 155226 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 155226 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 155227 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 155227 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 155229 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=16.6865234375,
floorSegmentMB=0.3828125, forceMergeDeletesPctAllowed=19.447903559770637,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 155230 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@9daf78c[collection1] main]
[junit4] 2> 155230 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 155230 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 155230 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 155231 INFO (searcherExecutor-576-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@9daf78c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 155232 INFO (coreLoadExecutor-575-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564213809234575360
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46040/ym/p/collection1/
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:46040/ym/p/collection1/ has no replicas
[junit4] 2> 155236 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 155238 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:46040/ym/p/collection1/ shard2
[junit4] 2> 155389 INFO (coreZkRegister-570-thread-1) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 155940 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/cores/collection1
[junit4] 2> 155941 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001
[junit4] 2> 155942 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 155942 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@d2009f3{/ym/p,null,AVAILABLE}
[junit4] 2> 155943 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1afead6d{HTTP/1.1,[http/1.1]}{127.0.0.1:41439}
[junit4] 2> 155943 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server Started @157527ms
[junit4] 2> 155943 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ym/p,
solrconfig=solrconfig.xml,
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/tempDir-001/jetty2,
hostPort=41439,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/cores}
[junit4] 2> 155943 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 155944 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 155944 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 155944 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 155944 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-04-09T15:08:55.947315Z
[junit4] 2> 155946 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 155946 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/solr.xml
[junit4] 2> 155953 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 155954 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46084/solr
[junit4] 2> 155961 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 155963 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 155964 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41439_ym%2Fp
[junit4] 2> 155965 INFO (zkCallback-498-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 155965 INFO (zkCallback-503-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 155965 INFO (zkCallback-494-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 155966 INFO (zkCallback-509-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 156124 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/cores
[junit4] 2> 156124 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 156125 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 156125 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 157134 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0
[junit4] 2> 157143 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 157191 WARN (coreLoadExecutor-586-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 157192 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 157203 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection collection1, trusted=true
[junit4] 2> 157204 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 157204 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-2-001/cores/collection1/data/]
[junit4] 2> 157204 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@44ac04d8
[junit4] 2> 157209 INFO (coreLoadExecutor-586-thread-1) [ ]
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.7602212447173758]
[junit4] 2> 157248 WARN (coreLoadExecutor-586-thread-1) [ ]
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> 157458 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 157458 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 157458 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 157458 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 157460 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=16.6865234375,
floorSegmentMB=0.3828125, forceMergeDeletesPctAllowed=19.447903559770637,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 157461 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@51ea3e81[collection1] main]
[junit4] 2> 157462 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 157462 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 157462 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 157463 INFO (searcherExecutor-587-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@51ea3e81[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 157465 INFO (coreLoadExecutor-586-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564213811576045568
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:41439/ym/p/collection1/
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:41439/ym/p/collection1/ has no replicas
[junit4] 2> 157469 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 157470 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:41439/ym/p/collection1/ shard1
[junit4] 2> 157621 INFO (coreZkRegister-581-thread-1) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 158159 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/cores/collection1
[junit4] 2> 158160 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001
[junit4] 2> 158161 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 158162 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@288456b1{/ym/p,null,AVAILABLE}
[junit4] 2> 158163 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@47de672{HTTP/1.1,[http/1.1]}{127.0.0.1:46396}
[junit4] 2> 158163 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server Started @159747ms
[junit4] 2> 158163 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ym/p,
solrconfig=solrconfig.xml,
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/tempDir-001/jetty3,
hostPort=46396,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/cores}
[junit4] 2> 158163 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 158163 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 158164 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 158164 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 158164 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-04-09T15:08:58.167130Z
[junit4] 2> 158166 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 158166 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/solr.xml
[junit4] 2> 158174 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 158177 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46084/solr
[junit4] 2> 158184 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 158185 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 158186 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46396_ym%2Fp
[junit4] 2> 158187 INFO (zkCallback-509-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 158187 INFO (zkCallback-498-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 158188 INFO (zkCallback-494-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 158188 INFO (zkCallback-503-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 158188 INFO (zkCallback-515-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 158309 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/cores
[junit4] 2> 158309 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 158310 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 158312 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
[junit4] 2> 159320 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0
[junit4] 2> 159328 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 159372 WARN (coreLoadExecutor-597-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 159373 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 159382 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection collection1, trusted=true
[junit4] 2> 159382 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 159382 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-3-001/cores/collection1/data/]
[junit4] 2> 159383 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@44ac04d8
[junit4] 2> 159385 INFO (coreLoadExecutor-597-thread-1) [ ]
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.7602212447173758]
[junit4] 2> 159433 WARN (coreLoadExecutor-597-thread-1) [ ]
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> 159562 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 159562 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 159563 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 159563 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 159564 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=16.6865234375,
floorSegmentMB=0.3828125, forceMergeDeletesPctAllowed=19.447903559770637,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 159565 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1f6e3faf[collection1] main]
[junit4] 2> 159566 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 159566 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 159566 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 159567 INFO (searcherExecutor-598-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1f6e3faf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 159568 INFO (coreLoadExecutor-597-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564213813781200896
[junit4] 2> 159571 INFO (coreZkRegister-592-thread-1) [ ]
o.a.s.c.ZkController Core needs to recover:collection1
[junit4] 2> 159571 INFO (updateExecutor-512-thread-1) [ ]
o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 159571 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 159572 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 159572 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Begin buffering updates. core=[collection1]
[junit4] 2> 159572 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 159572 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Publishing state of core [collection1] as recovering,
leader is [http://127.0.0.1:46040/ym/p/collection1/] and I am
[http://127.0.0.1:46396/ym/p/collection1/]
[junit4] 2> 159574 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Sending prep recovery command to
[http://127.0.0.1:46040/ym/p]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:46396_ym%252Fp&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 159577 INFO (qtp1362142432-1936) [ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 159577 INFO (qtp1362142432-1936) [ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard2 of collection1) have state: recovering
[junit4] 2> 159577 INFO (qtp1362142432-1936) [ ]
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:46396_ym%2Fp, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:46396/ym/p","node_name":"127.0.0.1:46396_ym%2Fp","state":"down"}
[junit4] 2> 160232 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/cores/collection1
[junit4] 2> 160232 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001
[junit4] 2> 160233 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 160234 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4f9ecbf8{/ym/p,null,AVAILABLE}
[junit4] 2> 160235 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@30644658{HTTP/1.1,[http/1.1]}{127.0.0.1:35060}
[junit4] 2> 160235 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.e.j.s.Server Started @161819ms
[junit4] 2> 160235 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/ym/p,
solrconfig=solrconfig.xml,
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/tempDir-001/jetty4,
hostPort=35060,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/cores}
[junit4] 2> 160235 ERROR
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 160235 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.6.0
[junit4] 2> 160236 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 160236 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 160236 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-04-09T15:09:00.239251Z
[junit4] 2> 160238 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 160238 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/solr.xml
[junit4] 2> 160243 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 160245 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46084/solr
[junit4] 2> 160251 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 160252 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 160253 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35060_ym%2Fp
[junit4] 2> 160254 INFO (zkCallback-503-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160254 INFO (zkCallback-509-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160254 INFO (zkCallback-494-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160254 INFO (zkCallback-498-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160255 INFO (zkCallback-515-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160254 INFO (zkCallback-522-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 160366 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/cores
[junit4] 2> 160366 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 160367 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 160368 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 160578 INFO (qtp1362142432-1936) [ ]
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:46396_ym%2Fp, coreNodeName=core_node3,
onlyIfActiveCheckResult=false, nodeProps:
core_node3:{"core":"collection1","base_url":"http://127.0.0.1:46396/ym/p","node_name":"127.0.0.1:46396_ym%2Fp","state":"recovering"}
[junit4] 2> 160578 INFO (qtp1362142432-1936) [ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering,
checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4] 2> 160578 INFO (qtp1362142432-1936) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:46396_ym%252Fp&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node3&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=1000
[junit4] 2> 161079 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Attempting to PeerSync from
[http://127.0.0.1:46040/ym/p/collection1/] - recoveringAfterStartup=[true]
[junit4] 2> 161079 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.PeerSync PeerSync: core=collection1 url=http://127.0.0.1:46396/ym/p
START replicas=[http://127.0.0.1:46040/ym/p/collection1/] nUpdates=100
[junit4] 2> 161081 INFO (qtp1362142432-1936) [ ]
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> 161081 INFO (qtp1362142432-1936) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/get
params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 161082 INFO (recoveryExecutor-513-thread-1) [ ]
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> 161082 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync
[junit4] 2> 161082 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 161082 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 161083 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 161083 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy PeerSync stage of recovery was successful.
[junit4] 2> 161083 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Replaying updates buffered during PeerSync.
[junit4] 2> 161083 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy No replay needed.
[junit4] 2> 161083 INFO (recoveryExecutor-513-thread-1) [ ]
o.a.s.c.RecoveryStrategy Registering as Active after recovery.
[junit4] 2> 161376 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.6.0
[junit4] 2> 161385 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 161433 WARN (coreLoadExecutor-608-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 161434 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 161443 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection collection1, trusted=true
[junit4] 2> 161443 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 161444 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.ShardSplitTest_7A53585934EF1B76-001/shard-4-001/cores/collection1/data/]
[junit4] 2> 161444 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@44ac04d8
[junit4] 2> 161447 INFO (coreLoadExecutor-608-thread-1) [ ]
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.7602212447173758]
[junit4] 2> 161475 WARN (coreLoadExecutor-608-thread-1) [ ]
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> 161607 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 161607 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 161607 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 161607 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 161608 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=19, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=16.6865234375,
floorSegmentMB=0.3828125, forceMergeDeletesPctAllowed=19.447903559770637,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 161609 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6d4cf001[collection1] main]
[junit4] 2> 161610 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 161610 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 161610 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 161611 INFO (searcherExecutor-609-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6d4cf001[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 161612 INFO (coreLoadExecutor-608-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1564213815924490240
[junit4] 2> 161615 INFO (coreZkRegister-603-thread-1) [ ]
o.a.s.c.ZkController Core needs to recover:collection1
[junit4] 2> 161615 INFO (updateExecutor-519-thread-1) [ ]
o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 161615 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 161616 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 161616 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Begin buffering updates. core=[collection1]
[junit4] 2> 161616 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 161616 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Publishing state of core [collection1] as recovering,
leader is [http://127.0.0.1:41439/ym/p/collection1/] and I am
[http://127.0.0.1:35060/ym/p/collection1/]
[junit4] 2> 161618 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Sending prep recovery command to
[http://127.0.0.1:41439/ym/p]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:35060_ym%252Fp&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 161619 INFO (qtp223847648-1963) [ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 161619 INFO (qtp223847648-1963) [ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard1 of collection1) have state: recovering
[junit4] 2> 161620 INFO (qtp223847648-1963) [ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard1, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=down, localState=active,
nodeName=127.0.0.1:35060_ym%2Fp, coreNodeName=core_node4,
onlyIfActiveCheckResult=false, nodeProps:
core_node4:{"core":"collection1","base_url":"http://127.0.0.1:35060/ym/p","node_name":"127.0.0.1:35060_ym%2Fp","state":"down"}
[junit4] 2> 161887 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSplitShardWithRule
[junit4] 2> 161887 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Wait for recoveries to finish - wait 15
for each attempt
[junit4] 2> 161887 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):15
[junit4] 2> 162620 INFO (qtp223847648-1963) [ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard1, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=recovering, localState=active,
nodeName=127.0.0.1:35060_ym%2Fp, coreNodeName=core_node4,
onlyIfActiveCheckResult=false, nodeProps:
core_node4:{"core":"collection1","base_url":"http://127.0.0.1:35060/ym/p","node_name":"127.0.0.1:35060_ym%2Fp","state":"recovering"}
[junit4] 2> 162620 INFO (qtp223847648-1963) [ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node4, state: recovering,
checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4] 2> 162620 INFO (qtp223847648-1963) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:35060_ym%252Fp&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node4&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=1000
[junit4] 2> 163121 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Attempting to PeerSync from
[http://127.0.0.1:41439/ym/p/collection1/] - recoveringAfterStartup=[true]
[junit4] 2> 163121 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.PeerSync PeerSync: core=collection1 url=http://127.0.0.1:35060/ym/p
START replicas=[http://127.0.0.1:41439/ym/p/collection1/] nUpdates=100
[junit4] 2> 163123 INFO (qtp223847648-1963) [ ]
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> 163123 INFO (qtp223847648-1963) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/get
params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 163124 INFO (recoveryExecutor-520-thread-1) [ ]
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> 163124 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync
[junit4] 2> 163124 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163124 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163125 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163125 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy PeerSync stage of recovery was successful.
[junit4] 2> 163125 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Replaying updates buffered during PeerSync.
[junit4] 2> 163125 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy No replay needed.
[junit4] 2> 163125 INFO (recoveryExecutor-520-thread-1) [ ]
o.a.s.c.RecoveryStrategy Registering as Active after recovery.
[junit4] 2> 163887 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 163889 INFO (qtp113764622-1902) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163889 INFO (qtp113764622-1902) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163890 INFO (qtp113764622-1902) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163890 INFO (qtp113764622-1902) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 1
[junit4] 2> 163896 INFO (qtp1362142432-1933) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163896 INFO (qtp1362142432-1933) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163896 INFO (qtp1792621787-1991) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163897 INFO (qtp1792621787-1991) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163897 INFO (qtp223847648-1965) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163897 INFO (qtp223847648-1965) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163897 INFO (qtp320132760-2025) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 163898 INFO (qtp320132760-2025) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 163898 INFO (qtp223847648-1965) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163898 INFO (qtp320132760-2025) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163898 INFO (qtp223847648-1965) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:46040/ym/p/collection1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 163898 INFO (qtp320132760-2025) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:46040/ym/p/collection1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 163898 INFO (qtp1362142432-1933) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163898 INFO (qtp1362142432-1933) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:46040/ym/p/collection1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 2
[junit4] 2> 163900 INFO (qtp1792621787-1991) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 163900 INFO (qtp1792621787-1991) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:46040/ym/p/collection1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 3
[junit4] 2> 163901 INFO (qtp1362142432-1935) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/ym/p path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
0 8
[junit4] 2> 163903 INFO (qtp1362142432-1932) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/select
params={q=*:*&distrib=false&tests=checkShardConsistency&rows=0&wt=javabin&version=2}
hits=0 status=0 QTime=0
[junit4] 2> 163906 INFO (qtp1792621787-1993) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/select
params={q=*:*&distrib=false&tests=checkShardConsistency&rows=0&wt=javabin&version=2}
hits=0 status=0 QTime=0
[junit4] 2> 163907 INFO (qtp223847648-1963) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/select
params={q=*:*&distrib=false&tests=checkShardConsistency&rows=0&wt=javabin&version=2}
hits=0 status=0 QTime=0
[junit4] 2> 163908 INFO (qtp320132760-2027) [ ] o.a.s.c.S.Request
[collection1] webapp=/ym/p path=/select
params={q=*:*&distrib=false&tests=checkShardConsistency&rows=0&wt=javabin&version=2}
hits=0 status=0 QTime=0
[junit4] 2> 165909 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ShardSplitTest Using legacyCloud=false for cluster
[junit4] 2> 165910 INFO (qtp113764622-1900) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 165912 INFO (qtp113764622-1900) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 165912 INFO
(TEST-ShardSplitTest.testSplitShardWithRule-seed#[7A53585934EF1B76]) [ ]
o.a.s.c.ShardSplitTest Starting testSplitShardWithRule
[junit4] 2> 165914 INFO (qtp113764622-1895) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&name=shardSplitWithRule&action=CREATE&numShards=1&rule=shard:*,replica:<2,node:*&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 165917 INFO (OverseerThreadFactory-562-thread-1) [ ]
o.a.s.c.CreateCollectionCmd Create collection shardSplitWithRule
[junit4] 2> 165917 INFO (OverseerThreadFactory-562-thread-1) [ ]
o.a.s.c.CreateCollectionCmd Only one config set found in zk - using it:conf1
[junit4] 2> 166023 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"shardSplitWithRule",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"shardSplitWithRule_shard1_replica1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37477/ym/p"}
[junit4] 2> 166024 INFO
(OverseerStateUpdate-97763362809577476-127.0.0.1:37477_ym%2Fp-n_0000000000) [
] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"shardSplitWithRule",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"shardSplitWithRule_shard1_replica2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:35060/ym/p"}
[junit4] 2> 166227 INFO (qtp320132760-2025) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=shardSplitWithRule_shard1_replica2&action=CREATE&numShards=1&collection=shardSplitWithRule&shard=shard1&wt=javabin&version=2
[junit4] 2> 166227 INFO (qtp113764622-1896) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&collection.configName=conf1&newCollection=true&name=shardSplitWithRule_shard1_replica1&action=CREATE&numShards=1&collection=shardSplitWithRule&shard=shard1&wt=javabin&version=2
[junit4] 2> 166333 INFO (zkCallback-522-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/shardSplitWithRule/state.json] for collection
[shardSplitWithRule] has occurred - updating... (live nodes size: [5])
[junit4] 2> 166333 INFO (zkCallback-494-thread-5) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/shardSplitWithRule/state.json] for collection
[shardSplitWithRule] has occurred - updating... (live nodes size: [5])
[junit4] 2> 166333 INFO (zkCallback-494-thread-7) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/shardSplitWithRule/state.json] for collection
[shardSplitWithRule] has occurred - updating... (live nodes size: [5])
[junit4] 2> 166333 INFO (zkCallback-522-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/shardSplitWithRule/state.json] for collection
[shardSplitWithRule] has occurred - updating... (live nodes size: [5])
[junit4] 2> 167238 INFO (qtp113764622-1896) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 167238 INFO (qtp320132760-2025) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.6.0
[junit4] 2> 167248 INFO (qtp320132760-2025) [ ] o.a.s.s.IndexSchema
[shardSplitWithRule_shard1_replica2] Schema name=test
[junit4] 2> 167249 INFO (qtp113764622-1896) [ ] o.a.s.s.IndexSchema
[shardSplitWithRule_shard1_replica1] Schema name=test
[junit4] 2> 167301 WARN (qtp320132760-2025) [ ] o.a.s.s.IndexSchema
[shardSplitWithRule_shard1_replica2] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 167302 WARN (qtp113764622-1896) [ ] o.a.s.s.IndexSchema
[shardSplitWithRule_shard1_replica1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 167303 INFO (qtp320132760-2025) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 167303 INFO (qtp113764622-18
[...truncated too long message...]
ValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1976856 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*}
0 0
[junit4] 2> 1976856 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[myid1]} 0 0
[junit4] 2> 1976857 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1976857 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@a6ab45b
[junit4] 2> 1977102 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.s.SolrIndexSearcher Opening [Searcher@28b4bc07[collection1] main]
[junit4] 2> 1977102 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1977102 INFO (searcherExecutor-8969-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@28b4bc07[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7n(6.6.0):C1)))}
[junit4] 2> 1977104 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 247
[junit4] 2> 1977104 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=id:myid*&fl=*&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1977105 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1977105 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1781108573
[junit4] 2> 1977105 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1977105 INFO (coreCloseExecutor-8973-thread-1) [ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@dbe3ade
[junit4] 2> 1977106 INFO (coreCloseExecutor-8973-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1977108 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1977109 INFO
(TEST-TestUseDocValuesAsStored.testManagedSchema-seed#[7A53585934EF1B76]) [
] o.a.s.SolrTestCaseJ4 ###Ending testManagedSchema
[junit4] 2> 1977110 INFO
(SUITE-TestUseDocValuesAsStored-seed#[7A53585934EF1B76]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestUseDocValuesAsStored_7A53585934EF1B76-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1978, maxMBSortInHeap=6.385304888997671,
sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=en-NL,
timezone=Etc/GMT-13
[junit4] 2> NOTE: Linux 4.4.0-66-generic amd64/Oracle Corporation 9-ea
(64-bit)/cpus=12,threads=1,free=301468232,total=533725184
[junit4] 2> NOTE: All tests run in this JVM: [ZkStateReaderTest,
TestConfigOverlay, TestPerFieldSimilarityWithDefaultOverride, TestCSVLoader,
RequestLoggingTest, CdcrReplicationHandlerTest,
TestExclusionRuleCollectionAccess, TestSolrCloudWithDelegationTokens,
ConfigSetsAPITest, TestDocumentBuilder, TestObjectReleaseTracker,
TestSolr4Spatial, TestSolr4Spatial2, SpatialRPTFieldTypeTest,
TestFieldResource, RecoveryAfterSoftCommitTest, TestBlendedInfixSuggestions,
ResponseHeaderTest, NotRequiredUniqueKeyTest, NumericFieldsTest,
HdfsRecoveryZkTest, TestIBSimilarityFactory, TestDFISimilarityFactory,
DistributedFacetPivotLongTailTest, TestDocBasedVersionConstraints,
DefaultValueUpdateProcessorTest, DeleteNodeTest, FastVectorHighlighterTest,
TestSolrQueryResponse, TestFastWriter, RequiredFieldsTest, FullHLLTest,
CloudMLTQParserTest, TestFilteredDocIdSet, JavabinLoaderTest,
CoreMergeIndexesAdminHandlerTest, TestManagedResourceStorage,
HighlighterConfigTest, TestCloudPivotFacet, ChangedSchemaMergeTest,
SolrMetricManagerTest, ReplicationFactorTest, TestFaceting, UUIDFieldTest,
TestFoldingMultitermQuery, TestXmlQParser, TestLRUStatsCache,
XsltUpdateRequestHandlerTest, SolrGangliaReporterTest,
ReplicaListTransformerTest, ParsingFieldUpdateProcessorsTest, DeleteStatusTest,
TestAtomicUpdateErrorCases, StatsReloadRaceTest, SyncSliceTest,
VersionInfoTest, TestRestoreCore, PKIAuthenticationIntegrationTest,
TestPHPSerializedResponseWriter, TestAddFieldRealTimeGet,
TestSchemaNameResource, MissingSegmentRecoveryTest, TestDocSet,
TestImpersonationWithHadoopAuth, TemplateUpdateProcessorTest,
TestComponentsName, StandardRequestHandlerTest, QueryElevationComponentTest,
ReturnFieldsTest, TestBinaryResponseWriter, TestReRankQParserPlugin,
DistributedExpandComponentTest, TestDynamicFieldCollectionResource,
TestDeleteCollectionOnDownNodes, TestTestInjection, SynonymTokenizerTest,
TestReplicationHandler, TestSolrCoreProperties, TestDistributedSearch,
HdfsDirectoryFactoryTest, TestFieldCacheVsDocValues, OverseerStatusTest,
TestLockTree, TestClassNameShortening, TestMacros, TestRandomDVFaceting,
BasicZkTest, BasicDistributedZkTest, BaseCdcrDistributedZkTest,
TestComplexPhraseQParserPlugin, ScriptEngineTest, SolrCLIZkUtilsTest,
AlternateDirectoryTest, CustomCollectionTest, TestPseudoReturnFields,
TestHdfsBackupRestoreCore, TestBinaryResponseWriter,
UUIDUpdateProcessorFallbackTest, TriLevelCompositeIdRoutingTest,
TestQuerySenderNoQuery, DistribJoinFromCollectionTest, TestRemoteStreaming,
TestHighlightDedupGrouping, TestSubQueryTransformerCrossCore, TestLazyCores,
TestFastLRUCache, FileBasedSpellCheckerTest, TestJettySolrRunner,
DateFieldTest, TestLeaderElectionZkExpiry, TestPathTrie,
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, OpenCloseCoreStressTest,
OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest,
FullSolrCloudDistribCmdsTest, TestRandomFaceting, ZkSolrClientTest, ZkCLITest,
AutoCommitTest, TestHashPartitioner, DistributedSpellCheckComponentTest,
TestReload, HardAutoCommitTest, TestRangeQuery, ShowFileRequestHandlerTest,
CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest,
CurrencyFieldXmlFileTest, SimplePostToolTest, AnalysisAfterCoreReloadTest,
SolrRequestParserTest, DocValuesTest, DirectUpdateHandlerOptimizeTest,
DocValuesMultiTest, TestSolrDeletionPolicy1, SolrInfoMBeanTest,
IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, TestWriterPerf,
DocumentAnalysisRequestHandlerTest, TermsComponentTest, RequestHandlersTest,
TestValueSourceCache, FieldAnalysisRequestHandlerTest, LoggingHandlerTest,
SolrPluginUtilsTest, UpdateRequestProcessorFactoryTest, MBeansHandlerTest,
TestAnalyzedSuggestions, TestPartialUpdateDeduplication, CSVRequestHandlerTest,
SearchHandlerTest, TestQuerySenderListener, BadComponentTest,
TestSolrDeletionPolicy2, SampleTest, MinimalSchemaTest,
TestElisionMultitermQuery, OutputWriterTest, ExternalFileFieldSortTest,
TestPostingsSolrHighlighter, DirectSolrConnectionTest, TestPhraseSuggestions,
TestCodecSupport, EchoParamsTest, TestDFRSimilarityFactory,
TestLMJelinekMercerSimilarityFactory, TestJmxMonitoredMap, ResourceLoaderTest,
PluginInfoTest, TestSystemIdResolver, TestSuggestSpellingConverter,
SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest,
ClusterStateTest, TestLRUCache, ZkNodePropsTest, SliceStateTest,
SystemInfoHandlerTest, FileUtilsTest, DistributedMLTComponentTest, TestRTGBase,
CursorPagingTest, DistributedIntervalFacetingTest, ConnectionReuseTest,
AsyncCallRequestStatusResponseTest, CollectionReloadTest,
CollectionStateFormat2Test, DeleteLastCustomShardedReplicaTest,
DeleteReplicaTest, DeleteShardTest, DistribCursorPagingTest,
DocValuesNotIndexedTest, LeaderElectionContextKeyTest,
LeaderFailureAfterFreshStartTest, LeaderInitiatedRecoveryOnCommitTest,
OverseerCollectionConfigSetProcessorTest, SSLMigrationTest,
SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest,
SharedFSAutoReplicaFailoverUtilsTest, SolrCloudExampleTest,
TestCloudInspectUtil, TestCloudPseudoReturnFields, TestCloudRecovery,
TestConfigSetsAPIExclusivity, TestDistribDocBasedVersion,
TestMiniSolrCloudCluster, TestOnReconnectListenerSupport, TestSSLRandomization,
TestSolrCloudWithSecureImpersonation, TestStressCloudBlindAtomicUpdates,
TlogReplayBufferedWhileIndexingTest, VMParamsZkACLAndCredentialsProvidersTest,
HdfsCollectionsAPIDistributedZkTest, HdfsRecoverLeaseTest, HdfsThreadLeakTest,
HdfsWriteToMultipleCollectionsTest, RulesTest, TestSolrDynamicMBean,
TestSolrXml, TestSolrCloudSnapshots, TestSQLHandlerNonCloud,
TestSolrConfigHandlerCloud, SmileWriterTest, SubstringBytesRefFilterTest,
TestIntervalFaceting, TestCustomDocTransformer, TestPushWriter,
TestRestManager, TestBulkSchemaAPI, TestManagedSynonymFilterFactory,
TestCollationFieldDocValues, TestManagedSchema, TestSchemaManager,
TestUseDocValuesAsStored]
[junit4] Completed [659/703 (2!)] on J0 in 56.40s, 6 tests, 1 error <<<
FAILURES!
[...truncated 36417 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
