You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/10/20 17:00:57 UTC

[JENKINS-EA] Lucene-Solr-6.x-Linux (32bit/jdk-9-ea+140) - Build # 1996 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1996/
Java: 32bit/jdk-9-ea+140 -server -XX:+UseConcMarkSweepGC

8 tests failed.
FAILED:  org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency

Error Message:
Path not found: /spellcheck/suggestions/[1]/suggestion

Stack Trace:
java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
	at __randomizedtesting.SeedInfo.seed([4FA949C6AA330951:C50EC63725D8302A]:0)
	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:901)
	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:848)
	at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	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:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet(UtilsToolTest.java:87)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testNonexisting

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testNonexisting(UtilsToolTest.java:98)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs(UtilsToolTest.java:105)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRelativePath

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRelativePath(UtilsToolTest.java:119)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.archiveGcLogs(SolrCLI.java:3442)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3428)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs(UtilsToolTest.java:138)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.archiveConsoleLogs(SolrCLI.java:3471)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3431)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs(UtilsToolTest.java:150)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRotateSolrLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.rotateSolrLogs(SolrCLI.java:3508)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3425)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRotateSolrLogs(UtilsToolTest.java:163)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)




Build Log:
[...truncated 10988 lines...]
   [junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_4FA949C6AA330951-001/init-core-data-001
   [junit4]   2> 344532 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 344532 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 344534 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 344672 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 344696 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 344869 WARN  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 344872 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 344922 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 344927 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 344997 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 345013 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 345122 WARN  (coreLoadExecutor-1417-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> 345124 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 345141 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 345142 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_4FA949C6AA330951-001/init-core-data-001/]
   [junit4]   2> 345143 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=70.5029296875, floorSegmentMB=0.3427734375, forceMergeDeletesPctAllowed=3.3550328233936666, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5788776756153554
   [junit4]   2> 345148 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 345148 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 345148 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=78.6904296875, floorSegmentMB=1.5322265625, forceMergeDeletesPctAllowed=21.210636741615282, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8181734923373349
   [junit4]   2> 345148 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@17855f4[collection1] main]
   [junit4]   2> 345149 WARN  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 345149 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 345183 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
   [junit4]   2> 345212 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
   [junit4]   2> 345221 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 345221 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 345271 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
   [junit4]   2> 345271 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
   [junit4]   2> 345272 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
   [junit4]   2> 345329 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
   [junit4]   2> 345644 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
   [junit4]   2> 345771 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
   [junit4]   2> 345771 INFO  (coreLoadExecutor-1417-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 345771 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 345773 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 345774 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
   [junit4]   2> 345775 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 345776 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 1
   [junit4]   2> 345777 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 345777 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 345777 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 345777 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 345783 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 345784 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 345784 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 345784 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 345784 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 345785 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 345785 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 345786 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 345786 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 345787 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 345787 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 345787 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 345788 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 345788 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 345790 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 345791 WARN  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 345793 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a16f9f[collection1] main]
   [junit4]   2> 345793 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 345793 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 345797 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 345798 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 345799 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17855f4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 345799 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 345800 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 345802 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 345802 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 345802 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 345802 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 345804 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 345804 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 345805 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 345807 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 345808 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 345810 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 345812 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 345812 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a16f9f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):C10)))}
   [junit4]   2> 345812 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 24
   [junit4]   2> 345817 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=4
   [junit4]   2> 345818 ERROR (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/suggestion
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/suggestion==[{'word':'document','freq':2}]
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":4},
   [junit4]   2>   "response":{"numFound":0,"start":0,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[],
   [junit4]   2>     "correctlySpelled":false}}
   [junit4]   2> 
   [junit4]   2>  request = q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true
   [junit4]   2> 345818 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
   [junit4]   2> 345818 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 345818 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 345819 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 345819 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 345819 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@63de4[collection1] main]
   [junit4]   2> 345819 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 345819 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 345965 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 346116 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 346241 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 346241 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 346410 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 346585 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 346725 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63de4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 346725 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 906
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency -Dtests.seed=4FA949C6AA330951 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uz-Arab-AF -Dtests.timezone=Asia/Pontianak -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.96s J1 | SpellCheckComponentTest.testThresholdTokenFrequency <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([4FA949C6AA330951:C50EC63725D8302A]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:901)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:848)
   [junit4]    > 	at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:277)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 346729 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testCollate
   [junit4]   2> 346730 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 346731 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 346731 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 346732 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 346732 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 346733 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 346733 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 346734 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 346735 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 346735 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 346735 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 346735 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 346737 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f7934[collection1] main]
   [junit4]   2> 346737 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 346737 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 347242 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 347379 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 347919 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 347920 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 348302 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 348518 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 348739 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f7934[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.3.0):C10)))}
   [junit4]   2> 348739 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 2004
   [junit4]   2> 348960 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.build=true&spellcheck.collate=true} hits=0 status=0 QTime=220
   [junit4]   2> 348962 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt+lowerfilt:broen^4&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=2
   [junit4]   2> 348967 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemtsss+broens&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=4
   [junit4]   2> 348969 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=pixma&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=1
   [junit4]   2> 348969 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testCollate
   [junit4]   2> 348969 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 348970 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 348971 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 348971 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 348971 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@ee5a88[collection1] main]
   [junit4]   2> 348971 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 348973 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 349079 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 349164 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 349253 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 349253 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 349305 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 349395 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 349493 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@ee5a88[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 349494 INFO  (TEST-SpellCheckComponentTest.testCollate-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 523
   [junit4]   2> 349496 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testMaximumResultsForSuggest
   [junit4]   2> 349497 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 1
   [junit4]   2> 349499 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 1
   [junit4]   2> 349500 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 349500 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 349501 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 349502 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 349503 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 349503 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 349504 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 349505 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 349505 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 349505 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 349508 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@16a9204[collection1] main]
   [junit4]   2> 349508 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 349508 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 349681 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 349756 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 349915 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 349915 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 350030 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 350155 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 350291 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@16a9204[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.3.0):C10)))}
   [junit4]   2> 350291 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 786
   [junit4]   2> 350505 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=7&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=213
   [junit4]   2> 350693 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=186
   [junit4]   2> 350694 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/numFound==1
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":186},
   [junit4]   2>   "command":"build",
   [junit4]   2>   "response":{"numFound":7,"start":0,"docs":[
   [junit4]   2>       {
   [junit4]   2>         "id":4,
   [junit4]   2>         "range_facet_l":[4],
   [junit4]   2>         "range_facet_l_dv":[4],
   [junit4]   2>         "range_facet_i_dv":[4],
   [junit4]   2>         "lowerfilt":["this blue"],
   [junit4]   2>         "lowerfilt1and2":["this blue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":5,
   [junit4]   2>         "range_facet_l":[5],
   [junit4]   2>         "range_facet_l_dv":[5],
   [junit4]   2>         "range_facet_i_dv":[5],
   [junit4]   2>         "lowerfilt":["this blud"],
   [junit4]   2>         "lowerfilt1and2":["this blud"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":6,
   [junit4]   2>         "range_facet_l":[6],
   [junit4]   2>         "range_facet_l_dv":[6],
   [junit4]   2>         "range_facet_i_dv":[6],
   [junit4]   2>         "lowerfilt":["this boue"],
   [junit4]   2>         "lowerfilt1and2":["this boue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.217Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":7,
   [junit4]   2>         "range_facet_l":[7],
   [junit4]   2>         "range_facet_l_dv":[7],
   [junit4]   2>         "range_facet_i_dv":[7],
   [junit4]   2>         "lowerfilt":["this glue"],
   [junit4]   2>         "lowerfilt1and2":["this glue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":8,
   [junit4]   2>         "range_facet_l":[8],
   [junit4]   2>         "range_facet_l_dv":[8],
   [junit4]   2>         "range_facet_i_dv":[8],
   [junit4]   2>         "lowerfilt":["this blee"],
   [junit4]   2>         "lowerfilt1and2":["this blee"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":0,
   [junit4]   2>         "range_facet_l":[0],
   [junit4]   2>         "range_facet_l_dv":[0],
   [junit4]   2>         "range_facet_i_dv":[0],
   [junit4]   2>         "lowerfilt":["This is a title"],
   [junit4]   2>         "lowerfilt1and2":["This is a title"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.211Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":2,
   [junit4]   2>         "range_facet_l":[2],
   [junit4]   2>         "range_facet_l_dv":[2],
   [junit4]   2>         "range_facet_i_dv":[2],
   [junit4]   2>         "lowerfilt":["This is a document"],
   [junit4]   2>         "lowerfilt1and2":["This is a document"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.214Z"}]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[]}}
   [junit4]   2> 
   [junit4]   2>  request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=6&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false
   [junit4]   2> 350909 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.90&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=214
   [junit4]   2> 351144 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.80&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=7 status=0 QTime=234
   [junit4]   2> 351145 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/numFound==1
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":234},
   [junit4]   2>   "command":"build",
   [junit4]   2>   "response":{"numFound":7,"start":0,"docs":[
   [junit4]   2>       {
   [junit4]   2>         "id":4,
   [junit4]   2>         "range_facet_l":[4],
   [junit4]   2>         "range_facet_l_dv":[4],
   [junit4]   2>         "range_facet_i_dv":[4],
   [junit4]   2>         "lowerfilt":["this blue"],
   [junit4]   2>         "lowerfilt1and2":["this blue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":5,
   [junit4]   2>         "range_facet_l":[5],
   [junit4]   2>         "range_facet_l_dv":[5],
   [junit4]   2>         "range_facet_i_dv":[5],
   [junit4]   2>         "lowerfilt":["this blud"],
   [junit4]   2>         "lowerfilt1and2":["this blud"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":6,
   [junit4]   2>         "range_facet_l":[6],
   [junit4]   2>         "range_facet_l_dv":[6],
   [junit4]   2>         "range_facet_i_dv":[6],
   [junit4]   2>         "lowerfilt":["this boue"],
   [junit4]   2>         "lowerfilt1and2":["this boue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.217Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":7,
   [junit4]   2>         "range_facet_l":[7],
   [junit4]   2>         "range_facet_l_dv":[7],
   [junit4]   2>         "range_facet_i_dv":[7],
   [junit4]   2>         "lowerfilt":["this glue"],
   [junit4]   2>         "lowerfilt1and2":["this glue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":8,
   [junit4]   2>         "range_facet_l":[8],
   [junit4]   2>         "range_facet_l_dv":[8],
   [junit4]   2>         "range_facet_i_dv":[8],
   [junit4]   2>         "lowerfilt":["this blee"],
   [junit4]   2>         "lowerfilt1and2":["this blee"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":0,
   [junit4]   2>         "range_facet_l":[0],
   [junit4]   2>         "range_facet_l_dv":[0],
   [junit4]   2>         "range_facet_i_dv":[0],
   [junit4]   2>         "lowerfilt":["This is a title"],
   [junit4]   2>         "lowerfilt1and2":["This is a title"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.211Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":2,
   [junit4]   2>         "range_facet_l":[2],
   [junit4]   2>         "range_facet_l_dv":[2],
   [junit4]   2>         "range_facet_i_dv":[2],
   [junit4]   2>         "lowerfilt":["This is a document"],
   [junit4]   2>         "lowerfilt1and2":["This is a document"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.214Z"}]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[]}}
   [junit4]   2> 
   [junit4]   2>  request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.80&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&fq=lowerfilt:th*&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false
   [junit4]   2> 351397 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.70&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=id:[0+TO+9]&spellcheck.extendedResults=false} hits=7 status=0 QTime=251
   [junit4]   2> 351624 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false} hits=7 status=0 QTime=226
   [junit4]   2> 351625 ERROR (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/numFound
   [junit4]   2>  expected =/spellcheck/suggestions/[1]/numFound==1
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":226},
   [junit4]   2>   "command":"build",
   [junit4]   2>   "response":{"numFound":7,"start":0,"docs":[
   [junit4]   2>       {
   [junit4]   2>         "id":4,
   [junit4]   2>         "range_facet_l":[4],
   [junit4]   2>         "range_facet_l_dv":[4],
   [junit4]   2>         "range_facet_i_dv":[4],
   [junit4]   2>         "lowerfilt":["this blue"],
   [junit4]   2>         "lowerfilt1and2":["this blue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":5,
   [junit4]   2>         "range_facet_l":[5],
   [junit4]   2>         "range_facet_l_dv":[5],
   [junit4]   2>         "range_facet_i_dv":[5],
   [junit4]   2>         "lowerfilt":["this blud"],
   [junit4]   2>         "lowerfilt1and2":["this blud"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.216Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":6,
   [junit4]   2>         "range_facet_l":[6],
   [junit4]   2>         "range_facet_l_dv":[6],
   [junit4]   2>         "range_facet_i_dv":[6],
   [junit4]   2>         "lowerfilt":["this boue"],
   [junit4]   2>         "lowerfilt1and2":["this boue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.217Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":7,
   [junit4]   2>         "range_facet_l":[7],
   [junit4]   2>         "range_facet_l_dv":[7],
   [junit4]   2>         "range_facet_i_dv":[7],
   [junit4]   2>         "lowerfilt":["this glue"],
   [junit4]   2>         "lowerfilt1and2":["this glue"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":8,
   [junit4]   2>         "range_facet_l":[8],
   [junit4]   2>         "range_facet_l_dv":[8],
   [junit4]   2>         "range_facet_i_dv":[8],
   [junit4]   2>         "lowerfilt":["this blee"],
   [junit4]   2>         "lowerfilt1and2":["this blee"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.218Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":0,
   [junit4]   2>         "range_facet_l":[0],
   [junit4]   2>         "range_facet_l_dv":[0],
   [junit4]   2>         "range_facet_i_dv":[0],
   [junit4]   2>         "lowerfilt":["This is a title"],
   [junit4]   2>         "lowerfilt1and2":["This is a title"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.211Z"},
   [junit4]   2>       {
   [junit4]   2>         "id":2,
   [junit4]   2>         "range_facet_l":[2],
   [junit4]   2>         "range_facet_l_dv":[2],
   [junit4]   2>         "range_facet_i_dv":[2],
   [junit4]   2>         "lowerfilt":["This is a document"],
   [junit4]   2>         "lowerfilt1and2":["This is a document"],
   [junit4]   2>         "multiDefault":["muLti-Default"],
   [junit4]   2>         "intDefault":42,
   [junit4]   2>         "timestamp":"2016-10-20T16:22:57.214Z"}]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[]}}
   [junit4]   2> 
   [junit4]   2>  request = q=lowerfilt:(this+OR+brwn)&spellcheck.maxResultsForSuggest=.64&qt=spellCheckCompRH&spellcheck=true&fq=id:[0+TO+9]&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.maxResultsForSuggest.fq=lowerfilt:th*&spellcheck.extendedResults=false
   [junit4]   2> 351626 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testMaximumResultsForSuggest
   [junit4]   2> 351626 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 351627 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 351627 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 351627 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 351628 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@437b3b[collection1] main]
   [junit4]   2> 351628 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 351628 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 351699 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 351753 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 351836 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 351836 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 351912 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 351983 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 352045 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@437b3b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 352047 INFO  (TEST-SpellCheckComponentTest.testMaximumResultsForSuggest-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 419
   [junit4]   2> 352056 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
   [junit4]   2> 352057 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 1
   [junit4]   2> 352058 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 352059 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 352060 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 352060 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 352061 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 352062 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 352062 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 352063 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 352063 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 352064 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 352065 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 352069 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8716c0[collection1] main]
   [junit4]   2> 352069 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 352069 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 352275 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 352332 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 352491 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 352491 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 352666 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 352806 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 352988 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8716c0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):C10)))}
   [junit4]   2> 352988 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 924
   [junit4]   2> 352989 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=1
   [junit4]   2> 352990 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[11231]} 0 0
   [junit4]   2> 352991 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 352991 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 352994 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@83360a[collection1] main]
   [junit4]   2> 352994 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 352994 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 353203 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 353271 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 353434 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 353434 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 353587 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 353733 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 353876 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@83360a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):C10) Uninverting(_4(6.3.0):C1)))}
   [junit4]   2> 353876 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 885
   [junit4]   2> 353878 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=889
   [junit4]   2> 353878 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
   [junit4]   2> 353879 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 353879 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 353879 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 353879 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 353880 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15c31b3[collection1] main]
   [junit4]   2> 353880 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 353880 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 353951 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 354039 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 354093 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 354093 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 354176 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 354271 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 354353 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15c31b3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 354353 INFO  (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 473
   [junit4]   2> 354355 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
   [junit4]   2> 354356 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 354357 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 354357 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 354358 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 354359 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 354359 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 354360 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 354360 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 354361 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 354361 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 354361 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 354361 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 354364 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@29a6d1[collection1] main]
   [junit4]   2> 354364 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 354364 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 354505 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 354560 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 354729 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 354729 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 354902 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 355022 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 355157 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@29a6d1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.3.0):C10)))}
   [junit4]   2> 355158 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 796
   [junit4]   2> 355159 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=12346&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 355159 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
   [junit4]   2> 355160 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 355160 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 355160 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 355160 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[4FA949C6AA330951]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c62bb8
   [junit4]   2> 355160 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-s

[...truncated too long message...]

 for spell checker: freq
   [junit4]   2> 365542 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 365608 INFO  (searcherExecutor-1418-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@750aca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 365608 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[4FA949C6AA330951]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 388
   [junit4]   2> 365609 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 365609 INFO  (SUITE-SpellCheckComponentTest-seed#[4FA949C6AA330951]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=9240808
   [junit4]   2> 365609 INFO  (coreCloseExecutor-1422-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6564fb
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_4FA949C6AA330951-001
   [junit4]   2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=3, maxDocsPerChunk=2, blockSize=4), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=3, blockSize=4)), sim=ClassicSimilarity, locale=uz-Arab-AF, timezone=Asia/Pontianak
   [junit4]   2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=131749592,total=283414528
   [junit4]   2> NOTE: All tests run in this JVM: [MoreLikeThisHandlerTest, SegmentsInfoRequestHandlerTest, OpenCloseCoreStressTest, TestSchemaResource, OverriddenZkACLAndCredentialsProvidersTest, CustomCollectionTest, TestDownShardTolerantSearch, TestSizeLimitedDistributedMap, JsonLoaderTest, IndexSchemaTest, SolrCmdDistributorTest, TestMiniSolrCloudCluster, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestSolrXml, TestChildDocTransformer, HdfsNNFailoverTest, LeaderFailureAfterFreshStartTest, TestFieldCacheSort, SoftAutoCommitTest, TestLuceneMatchVersion, TestFastOutputStream, DistributedSuggestComponentTest, TestConfigSetProperties, DistributedExpandComponentTest, HLLSerializationTest, DistanceFunctionTest, SimpleCollectionCreateDeleteTest, SpellingQueryConverterTest, TestExactStatsCache, TestTrie, SearchHandlerTest, SliceStateTest, SpellCheckComponentTest]
   [junit4] Completed [104/642 (1!)] on J1 in 21.11s, 11 tests, 1 error <<< FAILURES!

[...truncated 1711 lines...]
   [junit4] Suite: org.apache.solr.util.UtilsToolTest
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testEmptyAndQuiet <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet(UtilsToolTest.java:87)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testNonexisting <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testNonexisting(UtilsToolTest.java:98)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testRemoveOldSolrLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs(UtilsToolTest.java:105)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testRelativePath <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRelativePath(UtilsToolTest.java:119)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testRemoveOldGcLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.archiveGcLogs(SolrCLI.java:3442)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3428)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs(UtilsToolTest.java:138)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testArchiveConsoleLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.archiveConsoleLogs(SolrCLI.java:3471)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3431)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs(UtilsToolTest.java:150)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J2 | UtilsToolTest.testRotateSolrLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.rotateSolrLogs(SolrCLI.java:3508)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3425)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRotateSolrLogs(UtilsToolTest.java:163)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] Completed [638/642 (2!)] on J2 in 0.05s, 8 tests, 7 errors <<< FAILURES!

[...truncated 49948 lines...]


[JENKINS-EA] Lucene-Solr-6.x-Linux (32bit/jdk-9-ea+140) - Build # 1997 - Still Unstable!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1997/
Java: 32bit/jdk-9-ea+140 -server -XX:+UseParallelGC

8 tests failed.
FAILED:  org.apache.solr.cloud.ShardSplitTest.testSplitAfterFailedSplit

Error Message:
expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
	at __randomizedtesting.SeedInfo.seed([E571810644908A22:1C3C12A978E5C7A8]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.cloud.ShardSplitTest.testSplitAfterFailedSplit(ShardSplitTest.java:279)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	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:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet(UtilsToolTest.java:87)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testNonexisting

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testNonexisting(UtilsToolTest.java:98)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs(UtilsToolTest.java:105)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRelativePath

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRelativePath(UtilsToolTest.java:119)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.archiveGcLogs(SolrCLI.java:3442)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3428)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs(UtilsToolTest.java:138)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.archiveConsoleLogs(SolrCLI.java:3471)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3431)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs(UtilsToolTest.java:150)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)


FAILED:  org.apache.solr.util.UtilsToolTest.testRotateSolrLogs

Error Message:
Logs directory must be an absolute path, or -s must be supplied

Stack Trace:
java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
	at org.apache.solr.util.SolrCLI$UtilsTool.rotateSolrLogs(SolrCLI.java:3508)
	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3425)
	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
	at org.apache.solr.util.UtilsToolTest.testRotateSolrLogs(UtilsToolTest.java:163)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(java.base@9-ea/Method.java:535)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)




Build Log:
[...truncated 11537 lines...]
   [junit4] Suite: org.apache.solr.util.UtilsToolTest
   [junit4] ERROR   0.02s J1 | UtilsToolTest.testEmptyAndQuiet <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testEmptyAndQuiet(UtilsToolTest.java:87)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testNonexisting <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testNonexisting(UtilsToolTest.java:98)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testRemoveOldSolrLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRemoveOldSolrLogs(UtilsToolTest.java:105)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testRelativePath <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.removeOldSolrLogs(SolrCLI.java:3544)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3422)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRelativePath(UtilsToolTest.java:119)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testRemoveOldGcLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.archiveGcLogs(SolrCLI.java:3442)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3428)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRemoveOldGcLogs(UtilsToolTest.java:138)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testArchiveConsoleLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.archiveConsoleLogs(SolrCLI.java:3471)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3431)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testArchiveConsoleLogs(UtilsToolTest.java:150)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] ERROR   0.01s J1 | UtilsToolTest.testRotateSolrLogs <<<
   [junit4]    > Throwable #1: java.lang.Exception: Logs directory must be an absolute path, or -s must be supplied
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.prepareLogsPath(SolrCLI.java:3577)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.rotateSolrLogs(SolrCLI.java:3508)
   [junit4]    > 	at org.apache.solr.util.SolrCLI$UtilsTool.runTool(SolrCLI.java:3425)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.runTool(UtilsToolTest.java:183)
   [junit4]    > 	at org.apache.solr.util.UtilsToolTest.testRotateSolrLogs(UtilsToolTest.java:163)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(java.base@9-ea/Native Method)
   [junit4]    > 	at jdk.internal.reflect.NativeMethodAccessorImpl.invoke(java.base@9-ea/NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(java.base@9-ea/DelegatingMethodAccessorImpl.java:43)
   [junit4] Completed [276/642 (1!)] on J1 in 0.09s, 8 tests, 7 errors <<< FAILURES!

[...truncated 1138 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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/init-core-data-001
   [junit4]   2> 1854386 INFO  (SUITE-ShardSplitTest-seed#[E571810644908A22]-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> 1854386 INFO  (SUITE-ShardSplitTest-seed#[E571810644908A22]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /xc/k
   [junit4]   2> 1854387 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1854388 INFO  (Thread-3077) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1854388 INFO  (Thread-3077) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1854488 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkTestServer start zk server on port:33444
   [junit4]   2> 1854495 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854499 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854503 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854508 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854511 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854515 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854519 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854523 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854526 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854530 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1854534 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] 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> 1855269 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/cores/collection1
   [junit4]   2> 1855270 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1855271 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@137153a{/xc/k,null,AVAILABLE}
   [junit4]   2> 1855272 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Started ServerConnector@2f9ed6{HTTP/1.1,[http/1.1]}{127.0.0.1:38917}
   [junit4]   2> 1855272 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server Started @1857016ms
   [junit4]   2> 1855272 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/xc/k, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/tempDir-001/control/data, hostPort=38917, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/cores}
   [junit4]   2> 1855272 ERROR (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1855273 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.3.0
   [junit4]   2> 1855273 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1855273 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1855273 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-20T19:50:33.407261Z
   [junit4]   2> 1855275 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1855275 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/solr.xml
   [junit4]   2> 1855281 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1855282 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33444/solr
   [junit4]   2> 1855292 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38917_xc%2Fk
   [junit4]   2> 1855293 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.Overseer Overseer (id=96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) starting
   [junit4]   2> 1855296 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38917_xc%2Fk
   [junit4]   2> 1855297 INFO  (zkCallback-2486-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1855314 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/cores
   [junit4]   2> 1855315 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1855316 INFO  (OverseerStateUpdate-96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) [    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1856323 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1856333 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1856377 WARN  (coreLoadExecutor-6875-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> 1856379 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1856387 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
   [junit4]   2> 1856388 INFO  (coreLoadExecutor-6875-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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/cores/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/control-001/cores/collection1/data/]
   [junit4]   2> 1856388 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee5ee8
   [junit4]   2> 1856394 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7438179794131841]
   [junit4]   2> 1856484 WARN  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1856489 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1856489 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1856490 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1856491 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1856492 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1856493 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1135996[collection1] main]
   [junit4]   2> 1856494 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1856494 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1856494 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1856495 INFO  (searcherExecutor-6876-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1135996[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1856495 INFO  (coreLoadExecutor-6875-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1548739448279138304
   [junit4]   2> 1856502 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1856502 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1856502 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38917/xc/k/collection1/
   [junit4]   2> 1856502 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1856502 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.SyncStrategy http://127.0.0.1:38917/xc/k/collection1/ has no replicas
   [junit4]   2> 1856506 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38917/xc/k/collection1/ shard1
   [junit4]   2> 1856656 INFO  (coreZkRegister-6868-thread-1) [    ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1856822 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1856822 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 1856823 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 1857536 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/cores/collection1
   [junit4]   2> 1857537 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001
   [junit4]   2> 1857538 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1857538 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@10ae675{/xc/k,null,AVAILABLE}
   [junit4]   2> 1857539 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Started ServerConnector@1075a72{HTTP/1.1,[http/1.1]}{127.0.0.1:42417}
   [junit4]   2> 1857539 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server Started @1859282ms
   [junit4]   2> 1857539 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/xc/k, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/tempDir-001/jetty1, hostPort=42417, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/cores}
   [junit4]   2> 1857539 ERROR (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1857540 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.3.0
   [junit4]   2> 1857540 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1857540 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1857540 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-20T19:50:35.674166Z
   [junit4]   2> 1857542 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1857542 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/solr.xml
   [junit4]   2> 1857548 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1857550 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33444/solr
   [junit4]   2> 1857555 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1857557 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42417_xc%2Fk
   [junit4]   2> 1857558 INFO  (zkCallback-2486-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1857558 INFO  (zkCallback-2490-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1857558 INFO  (zkCallback-2496-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1857577 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/cores
   [junit4]   2> 1857577 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1857578 INFO  (OverseerStateUpdate-96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) [    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 1857680 INFO  (zkCallback-2496-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1858585 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1858594 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1858657 WARN  (coreLoadExecutor-6886-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> 1858658 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1858666 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1
   [junit4]   2> 1858666 INFO  (coreLoadExecutor-6886-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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/cores/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-1-001/cores/collection1/data/]
   [junit4]   2> 1858666 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee5ee8
   [junit4]   2> 1858672 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7438179794131841]
   [junit4]   2> 1858726 WARN  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1858738 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1858738 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1858740 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1858740 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1858741 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1858742 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@148d2a1[collection1] main]
   [junit4]   2> 1858743 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1858743 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1858743 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1858744 INFO  (searcherExecutor-6887-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@148d2a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1858744 INFO  (coreLoadExecutor-6886-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1548739450637385728
   [junit4]   2> 1858748 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1858748 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1858748 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:42417/xc/k/collection1/
   [junit4]   2> 1858748 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1858748 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.SyncStrategy http://127.0.0.1:42417/xc/k/collection1/ has no replicas
   [junit4]   2> 1858749 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:42417/xc/k/collection1/ shard2
   [junit4]   2> 1858851 INFO  (zkCallback-2496-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1858900 INFO  (coreZkRegister-6881-thread-1) [    ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1859002 INFO  (zkCallback-2496-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1859847 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/cores/collection1
   [junit4]   2> 1859848 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001
   [junit4]   2> 1859849 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1859849 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@da9ad2{/xc/k,null,AVAILABLE}
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Started ServerConnector@12c3714{HTTP/1.1,[http/1.1]}{127.0.0.1:39639}
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server Started @1861593ms
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/xc/k, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/tempDir-001/jetty2, hostPort=39639, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/cores}
   [junit4]   2> 1859850 ERROR (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.3.0
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1859850 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-20T19:50:37.984982Z
   [junit4]   2> 1859853 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1859853 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/solr.xml
   [junit4]   2> 1859859 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1859861 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33444/solr
   [junit4]   2> 1859866 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1859868 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39639_xc%2Fk
   [junit4]   2> 1859869 INFO  (zkCallback-2490-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1859869 INFO  (zkCallback-2486-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1859869 INFO  (zkCallback-2496-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1859869 INFO  (zkCallback-2502-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1859884 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/cores
   [junit4]   2> 1859884 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1859885 INFO  (OverseerStateUpdate-96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) [    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1859986 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1859986 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1860892 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1860900 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1860962 WARN  (coreLoadExecutor-6897-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> 1860963 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1860974 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1
   [junit4]   2> 1860974 INFO  (coreLoadExecutor-6897-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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/cores/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-2-001/cores/collection1/data/]
   [junit4]   2> 1860974 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee5ee8
   [junit4]   2> 1860983 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7438179794131841]
   [junit4]   2> 1861032 WARN  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1861038 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1861038 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1861040 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1861040 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1861041 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1861042 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@bbc089[collection1] main]
   [junit4]   2> 1861043 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1861043 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1861044 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1861044 INFO  (searcherExecutor-6898-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@bbc089[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1861045 INFO  (coreLoadExecutor-6897-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1548739453050159104
   [junit4]   2> 1861048 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1861049 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1861049 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39639/xc/k/collection1/
   [junit4]   2> 1861049 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1861049 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.SyncStrategy http://127.0.0.1:39639/xc/k/collection1/ has no replicas
   [junit4]   2> 1861050 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39639/xc/k/collection1/ shard1
   [junit4]   2> 1861152 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1861152 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1861201 INFO  (coreZkRegister-6892-thread-1) [    ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1861303 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1861303 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3])
   [junit4]   2> 1862110 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/cores/collection1
   [junit4]   2> 1862112 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001
   [junit4]   2> 1862112 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1862113 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1089e10{/xc/k,null,AVAILABLE}
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Started ServerConnector@1e6037e{HTTP/1.1,[http/1.1]}{127.0.0.1:33656}
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server Started @1863857ms
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/xc/k, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/tempDir-001/jetty3, hostPort=33656, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/cores}
   [junit4]   2> 1862114 ERROR (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.3.0
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1862114 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-20T19:50:40.248792Z
   [junit4]   2> 1862117 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1862117 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/solr.xml
   [junit4]   2> 1862122 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1862125 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33444/solr
   [junit4]   2> 1862130 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1862132 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33656_xc%2Fk
   [junit4]   2> 1862133 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1862133 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1862133 INFO  (zkCallback-2490-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1862133 INFO  (zkCallback-2486-thread-3) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1862133 INFO  (zkCallback-2508-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1862149 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/cores
   [junit4]   2> 1862149 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1862150 INFO  (OverseerStateUpdate-96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) [    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2
   [junit4]   2> 1862252 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1862252 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1862252 INFO  (zkCallback-2508-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1863157 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1863165 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1863209 WARN  (coreLoadExecutor-6908-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> 1863210 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1863217 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1
   [junit4]   2> 1863217 INFO  (coreLoadExecutor-6908-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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/cores/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-3-001/cores/collection1/data/]
   [junit4]   2> 1863217 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee5ee8
   [junit4]   2> 1863223 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7438179794131841]
   [junit4]   2> 1863278 WARN  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1863286 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1863286 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1863287 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1863287 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1863289 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 1863290 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c6b847[collection1] main]
   [junit4]   2> 1863291 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1863291 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1863291 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1863291 INFO  (searcherExecutor-6909-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c6b847[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1863292 INFO  (coreLoadExecutor-6908-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1548739455406309376
   [junit4]   2> 1863295 INFO  (coreZkRegister-6903-thread-1) [    ] o.a.s.c.ZkController Core needs to recover:collection1
   [junit4]   2> 1863295 INFO  (updateExecutor-2505-thread-1) [    ] o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 1863295 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 1863295 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
   [junit4]   2> 1863295 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.c.RecoveryStrategy Begin buffering updates. core=[collection1]
   [junit4]   2> 1863295 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
   [junit4]   2> 1863295 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.c.RecoveryStrategy Publishing state of core [collection1] as recovering, leader is [http://127.0.0.1:42417/xc/k/collection1/] and I am [http://127.0.0.1:33656/xc/k/collection1/]
   [junit4]   2> 1863298 INFO  (recoveryExecutor-2506-thread-1) [    ] o.a.s.c.RecoveryStrategy Sending prep recovery command to [http://127.0.0.1:42417/xc/k]; [WaitForState: action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:33656_xc%252Fk&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
   [junit4]   2> 1863301 INFO  (qtp22846021-14266) [    ] o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state: recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
   [junit4]   2> 1863301 INFO  (qtp22846021-14266) [    ] o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1 (shard2 of collection1) have state: recovering
   [junit4]   2> 1863301 INFO  (qtp22846021-14266) [    ] 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:33656_xc%2Fk, coreNodeName=core_node3, onlyIfActiveCheckResult=false, nodeProps: core_node3:{"core":"collection1","base_url":"http://127.0.0.1:33656/xc/k","node_name":"127.0.0.1:33656_xc%2Fk","state":"down"}
   [junit4]   2> 1863397 INFO  (zkCallback-2508-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1863397 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1863397 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 1864302 INFO  (qtp22846021-14266) [    ] 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:33656_xc%2Fk, coreNodeName=core_node3, onlyIfActiveCheckResult=false, nodeProps: core_node3:{"core":"collection1","base_url":"http://127.0.0.1:33656/xc/k","node_name":"127.0.0.1:33656_xc%2Fk","state":"recovering"}
   [junit4]   2> 1864302 INFO  (qtp22846021-14266) [    ] o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering, checkLive: true, onlyIfLeader: true for: 1 seconds.
   [junit4]   2> 1864302 INFO  (qtp22846021-14266) [    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={nodeName=127.0.0.1:33656_xc%252Fk&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> 1864346 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-4-001/cores/collection1
   [junit4]   2> 1864347 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-4-001
   [junit4]   2> 1864347 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1864348 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@c8e084{/xc/k,null,AVAILABLE}
   [junit4]   2> 1864348 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Started ServerConnector@1bebb27{HTTP/1.1,[http/1.1]}{127.0.0.1:35759}
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.e.j.s.Server Started @1866092ms
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/xc/k, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/tempDir-001/jetty4, hostPort=35759, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-4-001/cores}
   [junit4]   2> 1864349 ERROR (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 6.3.0
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1864349 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-20T19:50:42.483725Z
   [junit4]   2> 1864352 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 1864352 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-4-001/solr.xml
   [junit4]   2> 1864358 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1864359 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33444/solr
   [junit4]   2> 1864364 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1864366 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35759_xc%2Fk
   [junit4]   2> 1864367 INFO  (zkCallback-2486-thread-3) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864367 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864367 INFO  (zkCallback-2508-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864367 INFO  (zkCallback-2515-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864367 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864367 INFO  (zkCallback-2490-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1864416 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001/shard-4-001/cores
   [junit4]   2> 1864416 INFO  (TEST-ShardSplitTest.testSplitAfterFailedSplit-seed#[E571810644908A22]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1864418 INFO  (OverseerStateUpdate-96796215379558404-127.0.0.1:38917_xc%2Fk-n_0000000000) [    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 1864519 INFO  (zkCallback-2502-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 1864519 INFO  (zkCallback-2515-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 1864519 INFO  (zkCallback-2496-thread-2) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 1864519 INFO  (zkCallback-2508-thread-1) [    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 1865424 INFO  (coreLoadExecutor-6919-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1865432 INFO  (coreLoadExecutor-6919-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1

[...truncated too long message...]

junit4]   2> 2265845 INFO  (zkCallback-2696-thread-2) [    ] o.a.s.c.Overseer Overseer (id=96796238121730065-127.0.0.1:41617_xc%2Fk-n_0000000004) starting
   [junit4]   2> 2266838 INFO  (zkCallback-2696-thread-3) [    ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:41617/xc/k/collection1_shard1_1_replica0/
   [junit4]   2> 2266838 INFO  (zkCallback-2696-thread-3) [    ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 2266838 INFO  (zkCallback-2696-thread-3) [    ] o.a.s.c.SyncStrategy http://127.0.0.1:41617/xc/k/collection1_shard1_1_replica0/ has no replicas
   [junit4]   2> 2266840 INFO  (zkCallback-2696-thread-3) [    ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:41617/xc/k/collection1_shard1_1_replica0/ shard1_1
   [junit4]   2> 2267344 WARN  (zkCallback-2689-thread-1) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 2267344 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@19ff517{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2267345 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3c7b4d{/xc/k,null,UNAVAILABLE}
   [junit4]   2> 2267345 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.a.s.c.ChaosMonkey monkey: stop shard! 41617
   [junit4]   2> 2267345 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=28642765
   [junit4]   2> 2267346 INFO  (coreCloseExecutor-7532-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@18b6d91
   [junit4]   2> 2267346 INFO  (coreCloseExecutor-7532-thread-2) [    ] o.a.s.c.SolrCore [collection1_shard1_1_replica0]  CLOSING SolrCore org.apache.solr.core.SolrCore@1f0baa3
   [junit4]   2> 2267376 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.a.s.c.Overseer Overseer (id=96796238121730065-127.0.0.1:41617_xc%2Fk-n_0000000004) closing
   [junit4]   2> 2267376 INFO  (OverseerStateUpdate-96796238121730065-127.0.0.1:41617_xc%2Fk-n_0000000004) [    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:41617_xc%2Fk
   [junit4]   2> 2267377 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from client sessionid 0x157e3aa6cd70011, likely client has closed socket
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2> 	at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2> 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 2267377 INFO  (zkCallback-2672-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 2268877 WARN  (zkCallback-2696-thread-1) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 2268878 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@12e393d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2268878 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@92a2f6{/xc/k,null,UNAVAILABLE}
   [junit4]   2> 2268879 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.a.s.c.ChaosMonkey monkey: stop shard! 41339
   [junit4]   2> 2268880 INFO  (TEST-ShardSplitTest.testSplitWithChaosMonkey-seed#[E571810644908A22]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45288 45288
   [junit4]   2> 2268996 INFO  (Thread-3349) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45288 45288
   [junit4]   2> 2268996 WARN  (Thread-3349) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/aliases.json
   [junit4]   2> 	7	/solr/clusterprops.json
   [junit4]   2> 	6	/solr/security.json
   [junit4]   2> 	6	/solr/collections/collection1/state.json
   [junit4]   2> 	6	/solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	7	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/overseer_elect/election/96796238121730056-127.0.0.1:33647_xc%2Fk-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	54	/solr/overseer/collection-queue-work
   [junit4]   2> 	53	/solr/overseer/queue
   [junit4]   2> 	9	/solr/overseer/queue-work
   [junit4]   2> 	7	/solr/collections
   [junit4]   2> 	6	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 2268998 INFO  (SUITE-ShardSplitTest-seed#[E571810644908A22]-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/J1/temp/solr.cloud.ShardSplitTest_E571810644908A22-001
   [junit4]   2> Oct 20, 2016 7:57:27 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Lucene62, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=ee-TG, timezone=Africa/Kigali
   [junit4]   2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=90474592,total=404226048
   [junit4]   2> NOTE: All tests run in this JVM: [ZkStateWriterTest, ShardRoutingCustomTest, RulesTest, SmileWriterTest, DistributedFacetPivotWhiteBoxTest, TestPerFieldSimilarityClassic, TestMacroExpander, JsonLoaderTest, TermVectorComponentTest, URLClassifyProcessorTest, DistributedExpandComponentTest, SliceStateTest, SolrCmdDistributorTest, TestGeoJSONResponseWriter, BitVectorTest, TestRTGBase, RAMDirectoryFactoryTest, DistributedIntervalFacetingTest, TestMiniSolrCloudCluster, TestUpdate, TestOrdValues, TestSchemaResource, TestComplexPhraseQParserPlugin, TestInitQParser, TestLeaderRecoverFromLogOnStartup, MigrateRouteKeyTest, ConvertedLegacyTest, TestDefaultStatsCache, TestFastOutputStream, SegmentsInfoRequestHandlerTest, TestQueryUtils, VersionInfoTest, ConjunctionSolrSpellCheckerTest, TestInitParams, OpenCloseCoreStressTest, TestBlobHandler, GraphQueryTest, AnalysisErrorHandlingTest, TestDistributedGrouping, CSVRequestHandlerTest, SystemInfoHandlerTest, WrapperMergePolicyFactoryTest, TestSolrXml, LeaderFailureAfterFreshStartTest, TestSubQueryTransformerDistrib, TestTrie, CollectionsAPIDistributedZkTest, DeleteNodeTest, TestSuggestSpellingConverter, CachingDirectoryFactoryTest, DocumentBuilderTest, TestDownShardTolerantSearch, SolrXmlInZkTest, SimplePostToolTest, TestLeaderElectionWithEmptyReplica, DateRangeFieldTest, DirectSolrConnectionTest, BlockJoinFacetDistribTest, CollectionReloadTest, TestSolrIndexConfig, IndexBasedSpellCheckerTest, OverseerRolesTest, ReplaceNodeTest, ZkSolrClientTest, TestRestManager, TestBM25SimilarityFactory, TestConfigSetProperties, TestFieldCache, TestQuerySenderListener, JavabinLoaderTest, DistanceFunctionTest, PeerSyncReplicationTest, TestNoOpRegenerator, CustomCollectionTest, IndexSchemaTest, SpellingQueryConverterTest, TestOnReconnectListenerSupport, SortByFunctionTest, DistribJoinFromCollectionTest, TestSystemIdResolver, ZkCLITest, MergeStrategyTest, TestRequestStatusCollectionAPI, DistributedSuggestComponentTest, AnalyticsMergeStrategyTest, DistributedTermsComponentTest, SuggestComponentContextFilterQueryTest, TestRawTransformer, ShardRoutingTest, TestUniqueKeyFieldResource, TestCSVResponseWriter, ExitableDirectoryReaderTest, TestFileDictionaryLookup, TestSimpleTrackingShardHandler, TestFuzzyAnalyzedSuggestions, DirectSolrSpellCheckerTest, DocValuesTest, SpatialRPTFieldTypeTest, TestFieldTypeCollectionResource, TestClassicSimilarityFactory, TestRebalanceLeaders, SolrInfoMBeanTest, RollingRestartTest, HighlighterTest, UnloadDistributedZkTest, OverseerTest, BasicZkTest, ClusterStateUpdateTest, LeaderElectionTest, TestRandomDVFaceting, TermVectorComponentDistributedTest, TestReload, TestStressVersions, TestRangeQuery, TestSolr4Spatial, QueryElevationComponentTest, TestSort, TestFiltering, TestBadConfig, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SolrRequestParserTest, SpatialFilterTest, TestCSVLoader, PolyFieldTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, DocValuesMultiTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, TestQueryTypes, TermsComponentTest, RequestHandlersTest, RequiredFieldsTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, TestJmxIntegration, JSONWriterTest, TestPartialUpdateDeduplication, TestLFUCache, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, CdcrVersionReplicationTest, CollectionsAPIAsyncDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, ConfigSetsAPITest, CreateCollectionCleanupTest, DeleteShardTest, DistribDocExpirationUpdateProcessorTest, HttpPartitionTest, LeaderInitiatedRecoveryOnShardRestartTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerModifyCollectionTest, ReplicationFactorTest, RestartWhileUpdatingTest, SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest]
   [junit4] Completed [628/642 (2!)] on J1 in 415.64s, 5 tests, 1 failure <<< FAILURES!

[...truncated 49986 lines...]