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/25 12:42:57 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-9-ea+140) - Build # 18137 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18137/
Java: 64bit/jdk-9-ea+140 -XX:-UseCompressedOops -XX:+UseParallelGC

7 tests failed.
FAILED:  org.apache.solr.handler.component.SpellCheckComponentTest.test

Error Message:
List size mismatch @ spellcheck/suggestions

Stack Trace:
java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:7335DC2AFD3F3084]: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.test(SpellCheckComponentTest.java:147)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=STREAM}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=ENUM}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=SMART}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=DV}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=DVHASH}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=UIF}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)




Build Log:
[...truncated 11015 lines...]
   [junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_FB61E3F053C35D7C-001/init-core-data-001
   [junit4]   2> 546939 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 546940 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 546940 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 547007 WARN  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 547008 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 547023 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 547083 WARN  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 547084 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 547108 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 547169 WARN  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 547169 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 547183 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 547244 WARN  (coreLoadExecutor-2108-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> 547246 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 547266 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 547267 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.handler.component.SpellCheckComponentTest_FB61E3F053C35D7C-001/init-core-data-001/]
   [junit4]   2> 547267 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@4eae5306
   [junit4]   2> 547271 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 547271 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 547271 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=18.498046875, floorSegmentMB=1.791015625, forceMergeDeletesPctAllowed=2.354857980411248, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3000718426361252
   [junit4]   2> 547271 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4b5344fd[collection1] main]
   [junit4]   2> 547272 WARN  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 547272 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 547319 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
   [junit4]   2> 547349 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
   [junit4]   2> 547349 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
   [junit4]   2> 547349 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
   [junit4]   2> 547389 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
   [junit4]   2> 547389 INFO  (coreLoadExecutor-2108-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> 547389 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
   [junit4]   2> 547419 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
   [junit4]   2> 547529 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
   [junit4]   2> 547559 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
   [junit4]   2> 547559 INFO  (coreLoadExecutor-2108-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 547559 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 547560 INFO  (SUITE-SpellCheckComponentTest-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 547562 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 547562 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 547563 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 547564 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 547564 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 547564 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 547564 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 547564 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 547564 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 547564 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 547564 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 547565 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 547565 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 547565 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 547565 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 547566 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 547566 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 547566 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 547566 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 547566 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 547567 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 547568 WARN  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 547568 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 547569 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3172a903[collection1] main]
   [junit4]   2> 547569 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 547569 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 547570 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 547571 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 547571 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b5344fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 547571 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 547572 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
   [junit4]   2> 547574 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 547574 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
   [junit4]   2> 547574 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 547574 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
   [junit4]   2> 547575 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
   [junit4]   2> 547575 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 547576 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 547577 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 547578 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 547579 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 547580 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 547580 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3172a903[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c10)))}
   [junit4]   2> 547580 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 13
   [junit4]   2> 547581 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=0
   [junit4]   2> 547581 ERROR (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=List size mismatch @ spellcheck/suggestions
   [junit4]   2>  expected =/spellcheck=={'suggestions':['documemt',{'numFound':1,'startOffset':0,'endOffset':8,'suggestion':['document']}]}
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":0},
   [junit4]   2>   "response":{"numFound":0,"start":0,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "spellcheck":{
   [junit4]   2>     "suggestions":[]}}
   [junit4]   2> 
   [junit4]   2>  request = q=documemt&qt=spellCheckCompRH&spellcheck=true&wt=xml
   [junit4]   2> 547581 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 547582 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 547582 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 547582 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 547582 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 547582 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@79518934[collection1] main]
   [junit4]   2> 547583 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 547583 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 547634 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 547675 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 547732 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 547732 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 547803 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 547843 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 547913 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@79518934[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 547913 INFO  (TEST-SpellCheckComponentTest.test-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 330
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SpellCheckComponentTest -Dtests.method=test -Dtests.seed=FB61E3F053C35D7C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-IQ -Dtests.timezone=Asia/Kolkata -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.35s J1 | SpellCheckComponentTest.test <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: List size mismatch @ spellcheck/suggestions
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:7335DC2AFD3F3084]: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.test(SpellCheckComponentTest.java:147)
   [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> 547915 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
   [junit4]   2> 547916 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 547916 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 547916 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 547916 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 547917 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 547917 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 547917 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 547917 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 547917 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 547918 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 547918 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 547918 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 547920 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f335966[collection1] main]
   [junit4]   2> 547920 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 547920 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 548020 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 548071 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 548208 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 548208 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 548318 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 548436 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 548539 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f335966[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c10)))}
   [junit4]   2> 548539 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 621
   [junit4]   2> 548540 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
   [junit4]   2> 548540 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 548540 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 548540 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 548540 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 548541 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@62d81460[collection1] main]
   [junit4]   2> 548541 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 548541 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 548583 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 548652 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 548710 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 548710 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 548768 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 548818 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 548866 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@62d81460[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 548867 INFO  (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 326
   [junit4]   2> 548868 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
   [junit4]   2> 548869 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 548869 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 548870 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 548870 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 548870 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 548870 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 548871 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 548871 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 548871 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 548871 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 548872 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 548872 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 548875 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7728dfab[collection1] main]
   [junit4]   2> 548875 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 548875 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 549016 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 549061 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 549189 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 549189 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 549314 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 549466 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 549628 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7728dfab[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):c10)))}
   [junit4]   2> 549628 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 756
   [junit4]   2> 549630 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] 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=0
   [junit4]   2> 549632 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold_direct&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=2
   [junit4]   2> 549636 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
   [junit4]   2> 549636 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 549636 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 549636 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 549636 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 549637 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@124af87e[collection1] main]
   [junit4]   2> 549637 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 549637 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 549712 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 549787 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 549837 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 549837 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 549879 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 550296 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 550386 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@124af87e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 550386 INFO  (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 749
   [junit4]   2> 550388 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testPerDictionary
   [junit4]   2> 550388 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 550388 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 550388 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 550389 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 550389 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 550389 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 550389 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 550390 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 550390 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 550390 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 550390 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 550390 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 550392 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1efa0612[collection1] main]
   [junit4]   2> 550392 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 550392 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 550659 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 550758 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 550900 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 550900 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 550997 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 551099 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 551226 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1efa0612[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):c10)))}
   [junit4]   2> 551226 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 835
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=documemt&qt=spellCheckCompRH&spellcheck.dictionary=perDict&json.nl=map&spellcheck..perDict.foo=bar&spellcheck=true&spellcheck..perDict.bar=foo&wt=xml&spellcheck.build=true} hits=0 status=0 QTime=0
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testPerDictionary
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 551227 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@10c34954[collection1] main]
   [junit4]   2> 551228 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 551228 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 551283 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 551325 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 551394 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 551394 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 551457 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 551514 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 551562 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@10c34954[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 551562 INFO  (TEST-SpellCheckComponentTest.testPerDictionary-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 334
   [junit4]   2> 551571 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExtendedResultsCount
   [junit4]   2> 551572 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 551572 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 551572 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 551573 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 551573 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 551573 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 551573 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 551574 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 551574 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 551574 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 551574 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 551574 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 551577 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a3500e2[collection1] main]
   [junit4]   2> 551577 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 551577 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 551698 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 551732 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 551818 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 551818 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 551950 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 552069 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 552218 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a3500e2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c10)))}
   [junit4]   2> 552218 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 644
   [junit4]   2> 552379 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=0 status=0 QTime=160
   [junit4]   2> 552379 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=3&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=0
   [junit4]   2> 552379 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExtendedResultsCount
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@16d5ec28[collection1] main]
   [junit4]   2> 552380 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 552380 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 552445 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 552494 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 552572 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 552572 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 552622 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 552673 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 552740 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@16d5ec28[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 552740 INFO  (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 360
   [junit4]   2> 552742 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testNumericQuery
   [junit4]   2> 552743 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[0]} 0 0
   [junit4]   2> 552743 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[1]} 0 0
   [junit4]   2> 552743 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[2]} 0 0
   [junit4]   2> 552744 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[3]} 0 0
   [junit4]   2> 552744 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[4]} 0 0
   [junit4]   2> 552744 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[5]} 0 0
   [junit4]   2> 552745 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[6]} 0 0
   [junit4]   2> 552745 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[7]} 0 0
   [junit4]   2> 552746 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[8]} 0 0
   [junit4]   2> 552746 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[9]} 0 0
   [junit4]   2> 552746 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 552746 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@fb94eaf
   [junit4]   2> 552750 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@497f23af[collection1] main]
   [junit4]   2> 552750 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 552750 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
   [junit4]   2> 552937 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
   [junit4]   2> 553007 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
   [junit4]   2> 553281 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
   [junit4]   2> 553281 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
   [junit4]   2> 553546 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
   [junit4]   2> 553820 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
   [junit4]   2> 554082 INFO  (searcherExecutor-2109-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@497f23af[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):c10)))}
   [junit4]   2> 554083 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 1336
   [junit4]   2> 554083 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] 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> 554084 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testNumericQuery
   [junit4]   2> 554084 INFO  (TEST-SpellCheckComponentTest.testNumericQuery-seed#[FB61E3F053C35D7C]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 554084 INFO  (TEST-SpellCheckCompon

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

json.facet={cat0:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:cat_s,+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&num_i=num_i&sparse_s=sparse_s&NOW=1477397339653&isShard=true&num_fs=num_fs} hits=2 status=0 QTime=0
   [junit4]   2> 653934 INFO  (qtp1387082931-5243) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={date=date_dt&super_s=super_s&distrib=false&fl=id&fl=score&shards.purpose=1048580&noexist=noexist_s&fsv=true&shard.url=127.0.0.1:37007/solr/collection1&where_s=where_s&Z_num_i=Z_num_i&num_is=num_is&wt=javabin&multi_ss=multi_ss&_facet_={}&val_b=val_b&start=0&cat_s=cat_s&rows=0&version=2&num_d=num_d&q=*:*&json.facet={cat0:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:cat_s,+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:cat_s,+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&num_i=num_i&sparse_s=sparse_s&NOW=1477397339653&isShard=true&num_fs=num_fs} hits=2 status=0 QTime=0
   [junit4]   2> 653934 INFO  (qtp223552561-5260) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={date=date_dt&super_s=super_s&indent=true&noexist=noexist_s&val_b=val_b&cat_s=cat_s&rows=0&version=2.2&num_d=num_d&shards=127.0.0.1:42267/solr/collection1,127.0.0.1:37007/solr/collection1,127.0.0.1:45881/solr/collection1&shards=debugQuery&shards=false&q=*:*&json.facet={cat0:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:0},cat1:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:1},catDef:{type:terms,+field:${cat_s},+sort:'count+desc',+limit:1,+overrequest:-1},catBig:{type:terms,+field:${cat_s},+sort:'count+desc',+offset:1,+limit:2147483647,+overrequest:2147483647}}&num_i=num_i&sparse_s=sparse_s&where_s=where_s&Z_num_i=Z_num_i&num_is=num_is&wt=json&multi_ss=multi_ss&num_fs=num_fs} hits=6 status=0 QTime=1
   [junit4]   2> 653935 ERROR (TEST-TestJsonFacets.testStatsDistrib-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseHS query failed JSON validation. error=mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
   [junit4]   2>  expected =facets=={ count:6, cat0:{ buckets:[ {val:A,count:2} ] }, cat1:{ buckets:[ {val:B,count:3} ] }, catDef:{ buckets:[ {val:B,count:3} ] }, catBig:{ buckets:[ {val:A,count:2} ] }}
   [junit4]   2>  response = {
   [junit4]   2>   "responseHeader":{
   [junit4]   2>     "status":0,
   [junit4]   2>     "QTime":1},
   [junit4]   2>   "response":{"numFound":6,"start":0,"maxScore":1.0,"docs":[]
   [junit4]   2>   },
   [junit4]   2>   "facets":{
   [junit4]   2>     "count":6,
   [junit4]   2>     "catDef":{
   [junit4]   2>       "buckets":[{
   [junit4]   2>           "val":"B",
   [junit4]   2>           "count":3}]},
   [junit4]   2>     "cat0":{
   [junit4]   2>       "buckets":[{
   [junit4]   2>           "val":"B",
   [junit4]   2>           "count":3}]},
   [junit4]   2>     "cat1":{
   [junit4]   2>       "buckets":[{
   [junit4]   2>           "val":"B",
   [junit4]   2>           "count":3}]},
   [junit4]   2>     "catBig":{
   [junit4]   2>       "buckets":[{
   [junit4]   2>           "val":"A",
   [junit4]   2>           "count":2}]}}}
   [junit4]   2> 
   [junit4]   2> 653935 INFO  (TEST-TestJsonFacets.testStatsDistrib-seed#[FB61E3F053C35D7C]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStatsDistrib {p0=UIF}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestJsonFacets -Dtests.method=testStatsDistrib -Dtests.seed=FB61E3F053C35D7C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=bs-Cyrl -Dtests.timezone=Europe/Paris -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.25s J1 | TestJsonFacets.testStatsDistrib {p0=UIF} <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([FB61E3F053C35D7C:27A14A863E42F9B6]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
   [junit4]    > 	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
   [junit4]    > 	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
   [junit4]    > 	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
   [junit4]    > 	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
   [junit4]    > 	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
   [junit4]    > 	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
   [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> 653936 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@77e33769{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 653936 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=912262488
   [junit4]   2> 653937 INFO  (coreCloseExecutor-2602-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@2293f045
   [junit4]   2> 653950 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@75ad07f7{/solr,null,UNAVAILABLE}
   [junit4]   2> 653951 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@27a5883a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 653951 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1824417332
   [junit4]   2> 653951 INFO  (coreCloseExecutor-2604-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6970eef4
   [junit4]   2> 653965 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@71ff65a1{/solr,null,UNAVAILABLE}
   [junit4]   2> 653967 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@1dd17ad9{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 653967 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=206873862
   [junit4]   2> 653967 INFO  (coreCloseExecutor-2606-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@e502d0c
   [junit4]   2> 653985 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1960fdc1{/solr,null,UNAVAILABLE}
   [junit4]   2> 653985 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 653985 INFO  (SUITE-TestJsonFacets-seed#[FB61E3F053C35D7C]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1901599440
   [junit4]   2> 653985 INFO  (coreCloseExecutor-2608-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@18f9537a
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_FB61E3F053C35D7C-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), sim=ClassicSimilarity, locale=bs-Cyrl, timezone=Europe/Paris
   [junit4]   2> NOTE: Linux 4.4.0-42-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=152723760,total=530579456
   [junit4]   2> NOTE: All tests run in this JVM: [ChaosMonkeySafeLeaderTest, CursorMarkTest, TestDocTermOrds, TestDocumentBuilder, TestSortingResponseWriter, TestOverriddenPrefixQueryForCustomFieldType, AddSchemaFieldsUpdateProcessorFactoryTest, TimeZoneUtilsTest, DocumentBuilderTest, TestSimpleTrackingShardHandler, RuleEngineTest, RollingRestartTest, MigrateRouteKeyTest, SolrXmlInZkTest, IndexSchemaRuntimeFieldTest, TestSortByMinMaxFunction, HLLUtilTest, DistribJoinFromCollectionTest, TestFiltering, TestManagedSchemaThreadSafety, TestCustomDocTransformer, DistributedFacetPivotSmallAdvancedTest, ParsingFieldUpdateProcessorsTest, TestBlendedInfixSuggestions, TestReloadAndDeleteDocs, CollectionsAPIDistributedZkTest, DistributedQueryComponentCustomSortTest, HighlighterTest, SpellCheckCollatorTest, OverriddenZkACLAndCredentialsProvidersTest, TestDistributedGrouping, ZkStateReaderTest, TestXIncludeConfig, TestRequestStatusCollectionAPI, DataDrivenBlockJoinTest, TestFieldCacheVsDocValues, TestSolrCLIRunExample, UpdateRequestProcessorFactoryTest, JSONWriterTest, TestSolrDynamicMBean, InfoHandlerTest, SimpleCollectionCreateDeleteTest, ZkCLITest, TestBM25SimilarityFactory, HdfsThreadLeakTest, TestExactSharedStatsCache, OverseerRolesTest, TestXmlQParser, TestCloudRecovery, TestManagedSynonymFilterFactory, TestManagedResourceStorage, TestConfigSetImmutable, DirectSolrConnectionTest, ZkSolrClientTest, TestIntervalFaceting, TestMaxScoreQueryParser, SpellCheckComponentTest, BigEndianAscendingWordDeserializerTest, IndexBasedSpellCheckerTest, CustomCollectionTest, TestJsonFacets]
   [junit4] Completed [145/642 (2!)] on J1 in 23.23s, 48 tests, 6 errors <<< FAILURES!

[...truncated 51488 lines...]


[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+140) - Build # 18138 - Still Unstable!

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

7 tests failed.
FAILED:  org.apache.solr.cloud.RecoveryZkTest.test

Error Message:
There are still nodes recoverying - waited for 120 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 120 seconds
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:6EDF3CCBE498941F]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:184)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:862)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1418)
	at org.apache.solr.cloud.RecoveryZkTest.test(RecoveryZkTest.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 com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=SMART}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=DVHASH}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=STREAM}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=UIF}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=DV}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)


FAILED:  org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib {p0=ENUM}

Error Message:
mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val

Stack Trace:
java.lang.RuntimeException: mismatch: 'A'!='B' @ facets/cat0/buckets/[0]/val
	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:3A4BAA6727E55D2D]:0)
	at org.apache.solr.SolrTestCaseHS.matchJSON(SolrTestCaseHS.java:161)
	at org.apache.solr.SolrTestCaseHS.assertJQ(SolrTestCaseHS.java:143)
	at org.apache.solr.SolrTestCaseHS$Client$Tester.assertJQ(SolrTestCaseHS.java:255)
	at org.apache.solr.SolrTestCaseHS$Client.testJQ(SolrTestCaseHS.java:296)
	at org.apache.solr.search.facet.TestJsonFacets.doStatsTemplated(TestJsonFacets.java:1152)
	at org.apache.solr.search.facet.TestJsonFacets.doStats(TestJsonFacets.java:361)
	at org.apache.solr.search.facet.TestJsonFacets.testStatsDistrib(TestJsonFacets.java:322)
	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:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)




Build Log:
[...truncated 11303 lines...]
   [junit4] Suite: org.apache.solr.search.facet.TestJsonFacets
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/init-core-data-001
   [junit4]   2> 873692 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 873698 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 873699 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 873790 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 873799 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 873837 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 873883 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 873962 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 873970 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 874010 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 874043 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 874043 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/init-core-data-001/]
   [junit4]   2> 874044 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cc16e
   [junit4]   2> 874044 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5920976450469162]
   [junit4]   2> 874047 WARN  (coreLoadExecutor-2432-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> 874052 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 874052 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 874053 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 874053 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 874053 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=65.4248046875, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=21.398595297318877, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 874053 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@cb7726[collection1] main]
   [junit4]   2> 874053 WARN  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 874054 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 874054 INFO  (searcherExecutor-2433-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@cb7726[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 874054 INFO  (coreLoadExecutor-2432-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1549175429498142720
   [junit4]   2> 874057 INFO  (SUITE-TestJsonFacets-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 874058 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testBigger {p0=SMART}
   [junit4]   2> 874123 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 874123 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@63efba{/solr,null,AVAILABLE}
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.ServerConnector Started ServerConnector@17dc10{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server Started @??????ms
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=37987}
   [junit4]   2> 874124 ERROR (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 874124 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-25T15:20:18.790885Z
   [junit4]   2> 874125 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/solr.xml
   [junit4]   2> 874145 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/.
   [junit4]   2> 874145 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 874154 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 874163 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 874206 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 874231 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/./collection1
   [junit4]   2> 874231 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/./collection1/data/]
   [junit4]   2> 874231 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cc16e
   [junit4]   2> 874232 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5920976450469162]
   [junit4]   2> 874235 WARN  (coreLoadExecutor-2443-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> 874241 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 874241 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 874243 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 874243 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 874243 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=65.4248046875, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=21.398595297318877, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 874244 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@f2e836[collection1] main]
   [junit4]   2> 874245 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001/collection1/conf
   [junit4]   2> 874245 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 874246 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f2e836[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 874246 INFO  (coreLoadExecutor-2443-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1549175429699469312
   [junit4]   2> 874645 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.SolrTestCaseHS ===> Started solr server port=37987 home=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s0-001
   [junit4]   2> 874708 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 874709 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7c9be{/solr,null,AVAILABLE}
   [junit4]   2> 874709 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.ServerConnector Started ServerConnector@e92e31{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 874709 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server Started @??????ms
   [junit4]   2> 874709 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=35533}
   [junit4]   2> 874709 ERROR (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 874709 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 874710 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 874710 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 874710 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-25T15:20:19.376069Z
   [junit4]   2> 874710 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/solr.xml
   [junit4]   2> 874730 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/.
   [junit4]   2> 874730 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 874739 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 874748 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 874789 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 874813 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/./collection1
   [junit4]   2> 874813 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/./collection1/data/]
   [junit4]   2> 874813 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cc16e
   [junit4]   2> 874814 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5920976450469162]
   [junit4]   2> 874817 WARN  (coreLoadExecutor-2454-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> 874823 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 874823 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 874825 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 874825 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 874825 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=65.4248046875, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=21.398595297318877, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 874826 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b4006[collection1] main]
   [junit4]   2> 874826 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001/collection1/conf
   [junit4]   2> 874827 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 874827 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3b4006[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 874828 INFO  (coreLoadExecutor-2454-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1549175430309740544
   [junit4]   2> 875231 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.SolrTestCaseHS ===> Started solr server port=35533 home=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s1-001
   [junit4]   2> 875294 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 875294 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1aa4a37{/solr,null,AVAILABLE}
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.ServerConnector Started ServerConnector@fa0b17{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.Server Started @??????ms
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema_latest.xml, hostContext=/solr, solrconfig=solrconfig-tlog.xml, hostPort=40016}
   [junit4]   2> 875295 ERROR (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 875295 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-10-25T15:20:19.961866Z
   [junit4]   2> 875296 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/solr.xml
   [junit4]   2> 875315 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/.
   [junit4]   2> 875315 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 875325 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 875341 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 875376 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 875401 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/./collection1
   [junit4]   2> 875402 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/./collection1/data/]
   [junit4]   2> 875402 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cc16e
   [junit4]   2> 875402 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=47, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5920976450469162]
   [junit4]   2> 875405 WARN  (coreLoadExecutor-2465-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> 875412 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 875412 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 875414 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 875414 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 875414 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=65.4248046875, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=21.398595297318877, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 875414 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6e88d5[collection1] main]
   [junit4]   2> 875415 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001/collection1/conf
   [junit4]   2> 875415 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 875416 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6e88d5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 875416 INFO  (coreLoadExecutor-2465-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1549175430926303232
   [junit4]   2> 875820 INFO  (TEST-TestJsonFacets.testBigger-seed#[E68B03114A64F9E7]) [    ] o.a.s.SolrTestCaseHS ===> Started solr server port=40016 home=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_E68B03114A64F9E7-001/s2-001
   [junit4]   2> 875832 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1549175431359365120)} 0 2
   [junit4]   2> 875834 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1549175431362510848)} 0 1
   [junit4]   2> 875837 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1549175431365656576)} 0 1
   [junit4]   2> 875838 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0 (1549175431367753728)]} 0 0
   [junit4]   2> 875838 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1549175431368802304)]} 0 0
   [junit4]   2> 875840 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1549175431369850880)]} 0 1
   [junit4]   2> 875841 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3 (1549175431370899456)]} 0 0
   [junit4]   2> 875841 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[4 (1549175431371948032)]} 0 0
   [junit4]   2> 875841 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[5 (1549175431371948032)]} 0 0
   [junit4]   2> 875842 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[6 (1549175431372996608)]} 0 0
   [junit4]   2> 875842 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[7 (1549175431372996608)]} 0 0
   [junit4]   2> 875843 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[8 (1549175431374045184)]} 0 0
   [junit4]   2> 875843 INFO  (qtp29571586-4814) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875843 INFO  (qtp29571586-4814) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875846 INFO  (qtp29571586-4814) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4e6096[collection1] main]
   [junit4]   2> 875846 INFO  (qtp29571586-4814) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875846 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4e6096[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3)))}
   [junit4]   2> 875846 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 875847 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875847 INFO  (qtp23685847-4830) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@182e819
   [junit4]   2> 875848 INFO  (qtp23685847-4830) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1043a5b[collection1] main]
   [junit4]   2> 875848 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875848 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1043a5b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3)))}
   [junit4]   2> 875849 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875849 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875849 INFO  (qtp25782179-4846) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5eef05
   [junit4]   2> 875850 INFO  (qtp25782179-4846) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@121a6e4[collection1] main]
   [junit4]   2> 875850 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875851 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@121a6e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3)))}
   [junit4]   2> 875851 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875853 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[9 (1549175431382433792)]} 0 2
   [junit4]   2> 875855 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[10 (1549175431385579520)]} 0 1
   [junit4]   2> 875857 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[11 (1549175431387676672)]} 0 1
   [junit4]   2> 875858 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[12 (1549175431388725248)]} 0 0
   [junit4]   2> 875858 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[13 (1549175431389773824)]} 0 0
   [junit4]   2> 875859 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[14 (1549175431390822400)]} 0 0
   [junit4]   2> 875859 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[15 (1549175431390822400)]} 0 0
   [junit4]   2> 875860 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[16 (1549175431391870976)]} 0 0
   [junit4]   2> 875860 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[17 (1549175431391870976)]} 0 0
   [junit4]   2> 875861 INFO  (qtp29571586-4814) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875861 INFO  (qtp29571586-4814) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875862 INFO  (qtp29571586-4814) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@17071e9[collection1] main]
   [junit4]   2> 875862 INFO  (qtp29571586-4814) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875862 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17071e9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3)))}
   [junit4]   2> 875863 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875863 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875863 INFO  (qtp23685847-4830) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@182e819
   [junit4]   2> 875865 INFO  (qtp23685847-4830) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@10ced79[collection1] main]
   [junit4]   2> 875865 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875865 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@10ced79[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3)))}
   [junit4]   2> 875865 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875866 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875866 INFO  (qtp25782179-4846) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5eef05
   [junit4]   2> 875867 INFO  (qtp25782179-4846) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e02494[collection1] main]
   [junit4]   2> 875867 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875867 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e02494[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3)))}
   [junit4]   2> 875867 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875869 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[18 (1549175431400259584)]} 0 1
   [junit4]   2> 875871 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[19 (1549175431401308160)]} 0 1
   [junit4]   2> 875872 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[20 (1549175431403405312)]} 0 1
   [junit4]   2> 875873 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[21 (1549175431405502464)]} 0 0
   [junit4]   2> 875873 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[22 (1549175431405502464)]} 0 0
   [junit4]   2> 875874 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[23 (1549175431406551040)]} 0 0
   [junit4]   2> 875874 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[24 (1549175431406551040)]} 0 0
   [junit4]   2> 875875 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[25 (1549175431406551040)]} 0 0
   [junit4]   2> 875875 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[26 (1549175431407599616)]} 0 0
   [junit4]   2> 875876 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[27 (1549175431408648192)]} 0 0
   [junit4]   2> 875877 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[28 (1549175431409696768)]} 0 0
   [junit4]   2> 875877 INFO  (qtp29571586-4809) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875877 INFO  (qtp29571586-4809) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875879 INFO  (qtp29571586-4809) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@655bda[collection1] main]
   [junit4]   2> 875879 INFO  (qtp29571586-4809) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875880 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@655bda[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4)))}
   [junit4]   2> 875880 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875880 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875880 INFO  (qtp23685847-4830) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@182e819
   [junit4]   2> 875881 INFO  (qtp23685847-4830) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e7a2f3[collection1] main]
   [junit4]   2> 875881 INFO  (qtp23685847-4830) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875881 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e7a2f3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c3)))}
   [junit4]   2> 875882 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875882 INFO  (qtp25782179-4847) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875882 INFO  (qtp25782179-4847) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5eef05
   [junit4]   2> 875883 INFO  (qtp25782179-4847) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e75cc[collection1] main]
   [junit4]   2> 875884 INFO  (qtp25782179-4847) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875884 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5e75cc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4)))}
   [junit4]   2> 875884 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875886 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[29 (1549175431417036800)]} 0 1
   [junit4]   2> 875889 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[30 (1549175431419133952)]} 0 2
   [junit4]   2> 875890 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[31 (1549175431422279680)]} 0 1
   [junit4]   2> 875891 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[32 (1549175431424376832)]} 0 0
   [junit4]   2> 875892 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[33 (1549175431424376832)]} 0 0
   [junit4]   2> 875892 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[34 (1549175431425425408)]} 0 0
   [junit4]   2> 875892 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[35 (1549175431425425408)]} 0 0
   [junit4]   2> 875893 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[36 (1549175431426473984)]} 0 0
   [junit4]   2> 875893 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[37 (1549175431426473984)]} 0 0
   [junit4]   2> 875894 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[38 (1549175431426473984)]} 0 0
   [junit4]   2> 875894 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[39 (1549175431427522560)]} 0 0
   [junit4]   2> 875894 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[40 (1549175431427522560)]} 0 0
   [junit4]   2> 875895 INFO  (qtp29571586-4816) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875895 INFO  (qtp29571586-4816) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875896 INFO  (qtp29571586-4816) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a21e15[collection1] main]
   [junit4]   2> 875896 INFO  (qtp29571586-4816) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875897 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a21e15[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4) Uninverting(_3(7.0.0):c4)))}
   [junit4]   2> 875897 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875897 INFO  (qtp23685847-4831) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875898 INFO  (qtp23685847-4831) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@182e819
   [junit4]   2> 875899 INFO  (qtp23685847-4831) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@17d8970[collection1] main]
   [junit4]   2> 875900 INFO  (qtp23685847-4831) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875900 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17d8970[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c3) Uninverting(_3(7.0.0):c4)))}
   [junit4]   2> 875901 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
   [junit4]   2> 875901 INFO  (qtp25782179-4848) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875901 INFO  (qtp25782179-4848) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5eef05
   [junit4]   2> 875902 INFO  (qtp25782179-4848) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b1de1[collection1] main]
   [junit4]   2> 875902 INFO  (qtp25782179-4848) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875902 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7b1de1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4) Uninverting(_3(7.0.0):c4)))}
   [junit4]   2> 875902 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875904 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[41 (1549175431436959744)]} 0 1
   [junit4]   2> 875906 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[42 (1549175431439056896)]} 0 1
   [junit4]   2> 875908 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[43 (1549175431440105472)]} 0 1
   [junit4]   2> 875909 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[44 (1549175431442202624)]} 0 0
   [junit4]   2> 875909 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[45 (1549175431443251200)]} 0 0
   [junit4]   2> 875910 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[46 (1549175431443251200)]} 0 0
   [junit4]   2> 875910 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[47 (1549175431444299776)]} 0 0
   [junit4]   2> 875910 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[48 (1549175431444299776)]} 0 0
   [junit4]   2> 875911 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[49 (1549175431445348352)]} 0 0
   [junit4]   2> 875912 INFO  (qtp23685847-4831) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[50 (1549175431445348352)]} 0 1
   [junit4]   2> 875913 INFO  (qtp25782179-4848) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[51 (1549175431447445504)]} 0 0
   [junit4]   2> 875913 INFO  (qtp29571586-4816) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[52 (1549175431447445504)]} 0 0
   [junit4]   2> 875914 INFO  (qtp23685847-4832) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[53 (1549175431447445504)]} 0 0
   [junit4]   2> 875914 INFO  (qtp25782179-4841) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[54 (1549175431448494080)]} 0 0
   [junit4]   2> 875914 INFO  (qtp29571586-4815) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875914 INFO  (qtp29571586-4815) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875915 INFO  (qtp29571586-4815) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c047aa[collection1] main]
   [junit4]   2> 875916 INFO  (qtp29571586-4815) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875916 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c047aa[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4) Uninverting(_3(7.0.0):c4) Uninverting(_4(7.0.0):c4)))}
   [junit4]   2> 875916 INFO  (qtp29571586-4815) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875916 INFO  (qtp23685847-4825) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875917 INFO  (qtp23685847-4825) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@182e819
   [junit4]   2> 875917 INFO  (qtp23685847-4825) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8620a[collection1] main]
   [junit4]   2> 875918 INFO  (qtp23685847-4825) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875918 INFO  (searcherExecutor-2455-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8620a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c3) Uninverting(_3(7.0.0):c4) Uninverting(_4(7.0.0):c5)))}
   [junit4]   2> 875918 INFO  (qtp23685847-4825) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875918 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875918 INFO  (qtp25782179-4846) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5eef05
   [junit4]   2> 875919 INFO  (qtp25782179-4846) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bc0a4c[collection1] main]
   [junit4]   2> 875920 INFO  (qtp25782179-4846) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875920 INFO  (searcherExecutor-2466-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1bc0a4c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4) Uninverting(_3(7.0.0):c4) Uninverting(_4(7.0.0):c5)))}
   [junit4]   2> 875920 INFO  (qtp25782179-4846) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 875922 INFO  (qtp29571586-4814) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[55 (1549175431454785536)]} 0 1
   [junit4]   2> 875925 INFO  (qtp23685847-4830) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[56 (1549175431456882688)]} 0 2
   [junit4]   2> 875927 INFO  (qtp25782179-4847) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[57 (1549175431460028416)]} 0 1
   [junit4]   2> 875927 INFO  (qtp29571586-4809) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 875927 INFO  (qtp29571586-4809) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@9cb65
   [junit4]   2> 875928 INFO  (qtp29571586-4809) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@18b7165[collection1] main]
   [junit4]   2> 875929 INFO  (qtp29571586-4809) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 875929 INFO  (searcherExecutor-2444-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18b7165[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c3) Uninverting(_1(7.0.0):c3) Uninverting(_2(7.0.0):c4) Uninverting(_3(7.0.0):c4) Uninverting(_4(7.0.0):c4) Uninverting(_5(7.0.0):c1)))}
   [junit4]   2> 875929 INFO  (qtp29571586-4809) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 875930 INFO  (qtp23685847-4831) [    ] o.a.s.u.DirectUp

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

odes]
   [junit4]   2> 1541473 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@140f5a4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1541473 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1f1b6fe{/,null,UNAVAILABLE}
   [junit4]   2> 1541473 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.ChaosMonkey monkey: stop shard! 38821
   [junit4]   2> 1541473 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=13403413
   [junit4]   2> 1541473 WARN  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.RecoveryStrategy Stopping recovery for core=[collection1] coreNodeName=[core_node2]
   [junit4]   2> 1541475 WARN  (updateExecutor-1931-thread-2) [    ] o.a.s.u.DefaultSolrCoreState Skipping recovery because Solr is shutdown
   [junit4]   2> 1541579 INFO  (zkCallback-1934-thread-3) [    ] 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: [1])
   [junit4]   2> 1544975 INFO  (zkCallback-1934-thread-4) [    ] 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: [1])
   [junit4]   2> 1545884 INFO  (recoveryExecutor-1932-thread-1) [    ] o.a.s.c.RecoveryStrategy RecoveryStrategy has been closed
   [junit4]   2> 1545884 INFO  (recoveryExecutor-1932-thread-1) [    ] o.a.s.c.RecoveryStrategy Finished recovery process, successful=[false]
   [junit4]   2> 1545884 INFO  (recoveryExecutor-1932-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@e4b345
   [junit4]   2> 1545884 WARN  (recoveryExecutor-1932-thread-1) [    ] o.a.s.c.RecoveryStrategy Stopping recovery for core=[collection1] coreNodeName=[core_node2]
   [junit4]   2> 1545901 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.Overseer Overseer (id=96823499214880783-127.0.0.1:38821_-n_0000000003) closing
   [junit4]   2> 1545902 INFO  (OverseerStateUpdate-96823499214880783-127.0.0.1:38821_-n_0000000003) [    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:38821_
   [junit4]   2> 1545904 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@1b6afd5{HTTP/1.1,[http/1.1]}{127.0.0.1:38821}
   [junit4]   2> 1545904 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1e08870{/,null,UNAVAILABLE}
   [junit4]   2> 1545905 INFO  (TEST-RecoveryZkTest.test-seed#[E68B03114A64F9E7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35738 35738
   [junit4]   2> 1545920 INFO  (Thread-2324) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35738 35738
   [junit4]   2> 1545920 WARN  (Thread-2324) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	5	/solr/aliases.json
   [junit4]   2> 	5	/solr/clusterprops.json
   [junit4]   2> 	4	/solr/security.json
   [junit4]   2> 	4	/solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	5	/solr/clusterstate.json
   [junit4]   2> 	3	/solr/collections/collection1/state.json
   [junit4]   2> 	2	/solr/collections/collection1/leader_elect/shard1/election/96823499214880777-core_node1-n_0000000000
   [junit4]   2> 	2	/solr/overseer_elect/election/96823499214880777-127.0.0.1:46221_-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	137	/solr/overseer/collection-queue-work
   [junit4]   2> 	20	/solr/overseer/queue
   [junit4]   2> 	12	/solr/overseer/queue-work
   [junit4]   2> 	5	/solr/collections
   [junit4]   2> 	4	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RecoveryZkTest -Dtests.method=test -Dtests.seed=E68B03114A64F9E7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=bez -Dtests.timezone=America/Argentina/Rio_Gallegos -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE  140s J2 | RecoveryZkTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: There are still nodes recoverying - waited for 120 seconds
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([E68B03114A64F9E7:6EDF3CCBE498941F]:0)
   [junit4]    > 	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:184)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:862)
   [junit4]    > 	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1418)
   [junit4]    > 	at org.apache.solr.cloud.RecoveryZkTest.test(RecoveryZkTest.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]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    > 	at java.lang.Thread.run(java.base@9-ea/Thread.java:843)
   [junit4]   2> 1545924 INFO  (SUITE-RecoveryZkTest-seed#[E68B03114A64F9E7]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.RecoveryZkTest_E68B03114A64F9E7-001
   [junit4]   2> Oct 25, 2016 3:31:30 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {rnd_b=PostingsFormat(name=Asserting), _version_=PostingsFormat(name=LuceneVarGapFixedInterval), a_t=PostingsFormat(name=LuceneFixedGap), a_i=PostingsFormat(name=Asserting), id=PostingsFormat(name=Asserting)}, docValues:{}, maxPointsInLeafNode=819, maxMBSortInHeap=7.65014261024228, sim=ClassicSimilarity, locale=bez, timezone=America/Argentina/Rio_Gallegos
   [junit4]   2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=138677376,total=486449152
   [junit4]   2> NOTE: All tests run in this JVM: [TestUniqueKeyFieldResource, TestLuceneMatchVersion, URLClassifyProcessorTest, SynonymTokenizerTest, CoreAdminHandlerTest, TestHdfsBackupRestoreCore, CdcrBootstrapTest, AnalyticsMergeStrategyTest, HttpPartitionTest, FieldMutatingUpdateProcessorTest, TestConfig, TestNumericTerms64, TestInitQParser, TestTrackingShardHandlerFactory, XmlUpdateRequestHandlerTest, MergeStrategyTest, TestSerializedLuceneMatchVersion, SolrCoreCheckLockOnStartupTest, TestIndexingPerformance, TestDistributedStatsComponentCardinality, TestConfigSetsAPIZkFailure, FieldAnalysisRequestHandlerTest, BasicDistributedZk2Test, TestFieldCacheSort, TestNonDefinedSimilarityFactory, ConnectionReuseTest, SuggesterTSTTest, DistributedQueryComponentOptimizationTest, TestReRankQParserPlugin, TestGeoJSONResponseWriter, ConnectionManagerTest, AutoCommitTest, RulesTest, SimpleMLTQParserTest, DistributedDebugComponentTest, SmileWriterTest, LukeRequestHandlerTest, SolrCLIZkUtilsTest, StatelessScriptUpdateProcessorFactoryTest, SecurityConfHandlerTest, TestDynamicLoading, TestCollectionAPI, SolrTestCaseJ4Test, TestMacroExpander, PreAnalyzedUpdateProcessorTest, TestStressReorder, TestLMDirichletSimilarityFactory, TestFastOutputStream, TestRuleBasedAuthorizationPlugin, TestReversedWildcardFilterFactory, SpatialHeatmapFacetsTest, BadIndexSchemaTest, LeaderInitiatedRecoveryOnCommitTest, TestExactStatsCache, TestFilteredDocIdSet, TestMergePolicyConfig, PKIAuthenticationIntegrationTest, TestTolerantSearch, TestFieldCache, AssignTest, DistributedFacetPivotSmallTest, TestHdfsUpdateLog, TestIBSimilarityFactory, OutputWriterTest, OverseerCollectionConfigSetProcessorTest, CachingDirectoryFactoryTest, TestObjectReleaseTracker, DateRangeFieldTest, DeleteInactiveReplicaTest, SimpleFacetsTest, TestAuthenticationFramework, TestComplexPhraseQParserPlugin, HdfsTlogReplayBufferedWhileIndexingTest, DirectUpdateHandlerTest, TestReload, TestRestoreCore, PrimitiveFieldTypeTest, DistributedQueueTest, TestWriterPerf, CircularListTest, TestSolrQueryParser, TestBackupRepositoryFactory, TestConfigSetProperties, TestCopyFieldCollectionResource, TestDocSet, DistributedFacetPivotLargeTest, TestIndexSearcher, BlockJoinFacetSimpleTest, HardAutoCommitTest, TolerantUpdateProcessorTest, TestStressCloudBlindAtomicUpdates, PeerSyncWithIndexFingerprintCachingTest, TestDistributedMissingSort, SliceStateTest, TestRecovery, TestManagedSchema, TestSolrConfigHandlerCloud, HdfsDirectoryTest, TestStressUserVersions, ZkStateWriterTest, TestCollationField, TestMinMaxOnMultiValuedField, SparseHLLTest, TestSlowCompositeReaderWrapper, DocExpirationUpdateProcessorFactoryTest, BasicDistributedZkTest, UnloadDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, RecoveryZkTest]
   [junit4] Completed [338/642 (2!)] on J2 in 140.42s, 1 test, 1 failure <<< FAILURES!

[...truncated 50842 lines...]